[INFO] cloning repository https://github.com/agent-tools-org/ai-dispatch
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/agent-tools-org/ai-dispatch" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fagent-tools-org%2Fai-dispatch", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fagent-tools-org%2Fai-dispatch'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] beb7518ac096a4cdf33ab69bac8d95fd4bd9aaae
[INFO] testing agent-tools-org/ai-dispatch against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fagent-tools-org%2Fai-dispatch" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/agent-tools-org/ai-dispatch
[INFO] finished tweaking git repo https://github.com/agent-tools-org/ai-dispatch
[INFO] tweaked toml for git repo https://github.com/agent-tools-org/ai-dispatch written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/agent-tools-org/ai-dispatch on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/agent-tools-org/ai-dispatch already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rust-embed-utils v8.11.0
[INFO] [stderr]   Downloaded rusqlite v0.34.0
[INFO] [stderr]   Downloaded rust-embed-impl v8.11.0
[INFO] [stderr]   Downloaded rust-embed v8.11.0
[INFO] [stderr]   Downloaded instability v0.3.12
[INFO] [stderr]   Downloaded unicode-segmentation v1.13.1
[INFO] [stderr]   Downloaded libsqlite3-sys v0.32.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b5a4a4d53040cffbe3f8f4c4ca2ab5b20dac1813871ffb88abf7ba839becf60d
[INFO] running `Command { std: "docker" "start" "-a" "b5a4a4d53040cffbe3f8f4c4ca2ab5b20dac1813871ffb88abf7ba839becf60d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b5a4a4d53040cffbe3f8f4c4ca2ab5b20dac1813871ffb88abf7ba839becf60d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b5a4a4d53040cffbe3f8f4c4ca2ab5b20dac1813871ffb88abf7ba839becf60d", kill_on_drop: false }`
[INFO] [stdout] b5a4a4d53040cffbe3f8f4c4ca2ab5b20dac1813871ffb88abf7ba839becf60d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4f0badcd10fed1f2384452a7b71f04ca83c11d963c2eff441d690151fad531ff
[INFO] running `Command { std: "docker" "start" "-a" "4f0badcd10fed1f2384452a7b71f04ca83c11d963c2eff441d690151fad531ff", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.183
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling memoffset v0.6.5
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling libsqlite3-sys v0.32.0
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling instability v0.3.12
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling castaway v0.2.4
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling unicode-segmentation v1.13.1
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling compact_str v0.8.1
[INFO] [stderr]    Compiling lru v0.12.5
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling ai-dispatch v8.63.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling cassowary v0.3.0
[INFO] [stderr]    Compiling unicode-width v0.2.0
[INFO] [stderr]    Compiling unicode-truncate v1.1.0
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling serial-core v0.4.0
[INFO] [stderr]    Compiling termios v0.2.2
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling ioctl-rs v0.1.6
[INFO] [stderr]    Compiling serial-unix v0.4.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling serial v0.4.0
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling crossterm v0.28.1
[INFO] [stderr]    Compiling nix v0.25.1
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling filedescriptor v0.8.3
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling portable-pty v0.8.1
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling ratatui v0.29.0
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling rusqlite v0.34.0
[INFO] [stdout] warning: associated items `spawn_detached`, `id`, `wait`, `force_kill`, and `into_child` are never used
[INFO] [stdout]    --> src/process_guard.rs:33:12
[INFO] [stdout]     |
[INFO] [stdout]  16 | impl ProcessGuard {
[INFO] [stdout]     | ----------------- associated items in this implementation
[INFO] [stdout] ...
[INFO] [stdout]  33 |     pub fn spawn_detached(cmd: &mut Command) -> Result<Self> {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout]  41 |     pub fn id(&self) -> u32 {
[INFO] [stdout]     |            ^^
[INFO] [stdout] ...
[INFO] [stdout]  52 |     pub fn wait(&mut self) -> Result<ExitStatus> {
[INFO] [stdout]     |            ^^^^
[INFO] [stdout] ...
[INFO] [stdout] 103 |     pub fn force_kill(&mut self) {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 117 |     pub fn into_child(mut self) -> Child {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `kill` is never used
[INFO] [stdout]   --> src/pty_bridge.rs:67:12
[INFO] [stdout]    |
[INFO] [stdout] 15 | impl PtyBridge {
[INFO] [stdout]    | -------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 67 |     pub fn kill(&mut self) -> Result<()> {
[INFO] [stdout]    |            ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `cleanup_shared_dir` is never used
[INFO] [stdout]   --> src/shared_dir.rs:13:8
[INFO] [stdout]    |
[INFO] [stdout] 13 | pub fn cleanup_shared_dir(workgroup_id: &str) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `latest_milestone` is never used
[INFO] [stdout]   --> src/store/queries/event_queries.rs:30:12
[INFO] [stdout]    |
[INFO] [stdout] 14 | impl Store {
[INFO] [stdout]    | ---------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 30 |     pub fn latest_milestone(&self, task_id: &str) -> Result<Option<String>> {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `list_tools` is never used
[INFO] [stdout]    --> src/toolbox.rs:144:8
[INFO] [stdout]     |
[INFO] [stdout] 144 | pub fn list_tools() -> Vec<ToolMeta> {
[INFO] [stdout]     |        ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function `parse_str` is never used
[INFO] [stdout]    --> src/types.rs:289:12
[INFO] [stdout]     |
[INFO] [stdout] 279 | impl PendingReason {
[INFO] [stdout]     | ------------------ associated function in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 289 |     pub fn parse_str(s: &str) -> Option<Self> {
[INFO] [stdout]     |            ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 40s
[INFO] running `Command { std: "docker" "inspect" "4f0badcd10fed1f2384452a7b71f04ca83c11d963c2eff441d690151fad531ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4f0badcd10fed1f2384452a7b71f04ca83c11d963c2eff441d690151fad531ff", kill_on_drop: false }`
[INFO] [stdout] 4f0badcd10fed1f2384452a7b71f04ca83c11d963c2eff441d690151fad531ff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] cf6fdab213fa85297e42df202778f669810b062f91ed0200e162a74263933f48
[INFO] running `Command { std: "docker" "start" "-a" "cf6fdab213fa85297e42df202778f669810b062f91ed0200e162a74263933f48", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stdout] warning: associated items `spawn_detached`, `id`, `wait`, `force_kill`, and `into_child` are never used
[INFO] [stdout]    --> src/process_guard.rs:33:12
[INFO] [stdout]     |
[INFO] [stdout]  16 | impl ProcessGuard {
[INFO] [stdout]     | ----------------- associated items in this implementation
[INFO] [stdout] ...
[INFO] [stdout]  33 |     pub fn spawn_detached(cmd: &mut Command) -> Result<Self> {
[INFO] [stdout]     |            ^^^^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout]  41 |     pub fn id(&self) -> u32 {
[INFO] [stdout]     |            ^^
[INFO] [stdout] ...
[INFO] [stdout]  52 |     pub fn wait(&mut self) -> Result<ExitStatus> {
[INFO] [stdout]     |            ^^^^
[INFO] [stdout] ...
[INFO] [stdout] 103 |     pub fn force_kill(&mut self) {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 117 |     pub fn into_child(mut self) -> Child {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `kill` is never used
[INFO] [stdout]   --> src/pty_bridge.rs:67:12
[INFO] [stdout]    |
[INFO] [stdout] 15 | impl PtyBridge {
[INFO] [stdout]    | -------------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 67 |     pub fn kill(&mut self) -> Result<()> {
[INFO] [stdout]    |            ^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `cleanup_shared_dir` is never used
[INFO] [stdout]   --> src/shared_dir.rs:13:8
[INFO] [stdout]    |
[INFO] [stdout] 13 | pub fn cleanup_shared_dir(workgroup_id: &str) {
[INFO] [stdout]    |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: method `latest_milestone` is never used
[INFO] [stdout]   --> src/store/queries/event_queries.rs:30:12
[INFO] [stdout]    |
[INFO] [stdout] 14 | impl Store {
[INFO] [stdout]    | ---------- method in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 30 |     pub fn latest_milestone(&self, task_id: &str) -> Result<Option<String>> {
[INFO] [stdout]    |            ^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `list_tools` is never used
[INFO] [stdout]    --> src/toolbox.rs:144:8
[INFO] [stdout]     |
[INFO] [stdout] 144 | pub fn list_tools() -> Vec<ToolMeta> {
[INFO] [stdout]     |        ^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: associated function `parse_str` is never used
[INFO] [stdout]    --> src/types.rs:289:12
[INFO] [stdout]     |
[INFO] [stdout] 279 | impl PendingReason {
[INFO] [stdout]     | ------------------ associated function in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 289 |     pub fn parse_str(s: &str) -> Option<Self> {
[INFO] [stdout]     |            ^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling ai-dispatch v8.63.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: methods `force_kill` and `into_child` are never used
[INFO] [stdout]    --> src/process_guard.rs:103:12
[INFO] [stdout]     |
[INFO] [stdout]  16 | impl ProcessGuard {
[INFO] [stdout]     | ----------------- methods in this implementation
[INFO] [stdout] ...
[INFO] [stdout] 103 |     pub fn force_kill(&mut self) {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 117 |     pub fn into_child(mut self) -> Child {
[INFO] [stdout]     |            ^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 36.84s
[INFO] running `Command { std: "docker" "inspect" "cf6fdab213fa85297e42df202778f669810b062f91ed0200e162a74263933f48", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf6fdab213fa85297e42df202778f669810b062f91ed0200e162a74263933f48", kill_on_drop: false }`
[INFO] [stdout] cf6fdab213fa85297e42df202778f669810b062f91ed0200e162a74263933f48
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3919bf9d9359d5991c36b84792d9735d9fcbe2399e09b68f3f01825ef166d3c4
[INFO] running `Command { std: "docker" "start" "-a" "3919bf9d9359d5991c36b84792d9735d9fcbe2399e09b68f3f01825ef166d3c4", kill_on_drop: false }`
[INFO] [stderr] warning: methods `force_kill` and `into_child` are never used
[INFO] [stderr]    --> src/process_guard.rs:103:12
[INFO] [stderr]     |
[INFO] [stderr]  16 | impl ProcessGuard {
[INFO] [stderr]     | ----------------- methods in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 103 |     pub fn force_kill(&mut self) {
[INFO] [stderr]     |            ^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 117 |     pub fn into_child(mut self) -> Child {
[INFO] [stderr]     |            ^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `ai-dispatch` (bin "aid" test) generated 1 warning
[INFO] [stderr] warning: associated items `spawn_detached`, `id`, `wait`, `force_kill`, and `into_child` are never used
[INFO] [stderr]    --> src/process_guard.rs:33:12
[INFO] [stderr]     |
[INFO] [stderr]  16 | impl ProcessGuard {
[INFO] [stderr]     | ----------------- associated items in this implementation
[INFO] [stderr] ...
[INFO] [stderr]  33 |     pub fn spawn_detached(cmd: &mut Command) -> Result<Self> {
[INFO] [stderr]     |            ^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr]  41 |     pub fn id(&self) -> u32 {
[INFO] [stderr]     |            ^^
[INFO] [stderr] ...
[INFO] [stderr]  52 |     pub fn wait(&mut self) -> Result<ExitStatus> {
[INFO] [stderr]     |            ^^^^
[INFO] [stderr] ...
[INFO] [stderr] 103 |     pub fn force_kill(&mut self) {
[INFO] [stderr]     |            ^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 117 |     pub fn into_child(mut self) -> Child {
[INFO] [stderr]     |            ^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: method `kill` is never used
[INFO] [stderr]   --> src/pty_bridge.rs:67:12
[INFO] [stderr]    |
[INFO] [stderr] 15 | impl PtyBridge {
[INFO] [stderr]    | -------------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 67 |     pub fn kill(&mut self) -> Result<()> {
[INFO] [stderr]    |            ^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function `cleanup_shared_dir` is never used
[INFO] [stderr]   --> src/shared_dir.rs:13:8
[INFO] [stderr]    |
[INFO] [stderr] 13 | pub fn cleanup_shared_dir(workgroup_id: &str) {
[INFO] [stderr]    |        ^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method `latest_milestone` is never used
[INFO] [stderr]   --> src/store/queries/event_queries.rs:30:12
[INFO] [stderr]    |
[INFO] [stderr] 14 | impl Store {
[INFO] [stderr]    | ---------- method in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 30 |     pub fn latest_milestone(&self, task_id: &str) -> Result<Option<String>> {
[INFO] [stderr]    |            ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function `list_tools` is never used
[INFO] [stderr]    --> src/toolbox.rs:144:8
[INFO] [stderr]     |
[INFO] [stderr] 144 | pub fn list_tools() -> Vec<ToolMeta> {
[INFO] [stderr]     |        ^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: associated function `parse_str` is never used
[INFO] [stderr]    --> src/types.rs:289:12
[INFO] [stderr]     |
[INFO] [stderr] 279 | impl PendingReason {
[INFO] [stderr]     | ------------------ associated function in this implementation
[INFO] [stderr] ...
[INFO] [stderr] 289 |     pub fn parse_str(s: &str) -> Option<Self> {
[INFO] [stderr]     |            ^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `ai-dispatch` (bin "aid") generated 6 warnings
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.30s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/aid-befc9e1567d0b429)
[INFO] [stdout] 
[INFO] [stdout] running 866 tests
[INFO] [stdout] test agent::classifier::tests::frontend_react ... ok
[INFO] [stdout] test agent::classifier::tests::complex_impl_long ... ok
[INFO] [stdout] test agent::classifier::tests::research_question ... ok
[INFO] [stdout] test agent::classifier::tests::debugging_category ... ok
[INFO] [stdout] test agent::classifier::tests::simple_edit_rename ... ok
[INFO] [stdout] test agent::classifier::tests::low_complexity_short ... ok
[INFO] [stdout] test agent::classifier::tests::high_complexity_long ... ok
[INFO] [stdout] test agent::classifier::tests::refactoring_category ... ok
[INFO] [stdout] test agent::classifier::tests::testing_category ... ok
[INFO] [stdout] test agent::codex::tests::build_command_includes_skip_git_repo_check ... ok
[INFO] [stdout] test agent::codex::tests::build_command_read_only_prepends_readonly_prefix ... ok
[INFO] [stdout] test agent::codex::tests::parses_agent_message_items ... ok
[INFO] [stdout] test agent::codex::tests::parses_item_error_events ... ok
[INFO] [stdout] test agent::codebuff::tests::parses_codex_compatible_events ... ok
[INFO] [stdout] test agent::codex::tests::build_command_read_only_uses_full_auto ... ok
[INFO] [stdout] test agent::codex::tests::semver_parsing ... ok
[INFO] [stdout] test agent::codex::tests::parses_thread_started_session_id ... ok
[INFO] [stdout] test agent::codex::tests::parses_turn_completed_usage_metadata ... ok
[INFO] [stdout] test agent::cursor::tests::parses_result_event_with_usage ... ok
[INFO] [stdout] test agent::codex::tests::parses_file_change_events ... ok
[INFO] [stdout] test agent::cursor::tests::parses_tool_call_write ... ok
[INFO] [stdout] test agent::cursor::tests::skips_all_thinking_deltas ... ok
[INFO] [stdout] test agent::codex::tests::version_comparison_for_model_flag ... ok
[INFO] [stdout] test agent::cursor::tests::parses_tool_call_glob ... ok
[INFO] [stdout] test agent::cursor::tests::parses_assistant_message ... ok
[INFO] [stdout] test agent::cursor::tests::extracts_model_from_system_event ... ok
[INFO] [stdout] test agent::cursor::tests::uses_cursor_agent_binary ... ok
[INFO] [stdout] test agent::custom::tests::build_command_with_dir ... ok
[INFO] [stdout] test agent::custom::tests::build_command_with_arg_mode ... ok
[INFO] [stdout] test agent::custom::tests::build_command_with_flag_mode ... ok
[INFO] [stdout] test agent::custom::tests::parse_event_jsonl ... ok
[INFO] [stdout] test agent::custom::tests::parse_event_text ... ok
[INFO] [stdout] test agent::custom::tests::parse_full_config ... ok
[INFO] [stdout] test agent::custom::tests::parse_minimal_config ... ok
[INFO] [stdout] test agent::droid::tests::build_command_read_only_uses_auto_low ... ok
[INFO] [stdout] test agent::droid::tests::build_command_with_dir_sets_cwd ... ok
[INFO] [stdout] test agent::codebuff::tests::parses_turn_completed_usage ... ok
[INFO] [stdout] test agent::gemini::tests::extract_response_from_new_format_message_deltas ... ok
[INFO] [stdout] test agent::droid::tests::parses_tool_call_events_with_tool_name ... ok
[INFO] [stdout] test agent::gemini::tests::parses_gemini_cli_tool_use_event ... ok
[INFO] [stdout] test agent::droid::tests::build_command_uses_droid_exec ... ok
[INFO] [stdout] test agent::gemini::tests::parses_tool_call_event ... ok
[INFO] [stdout] test agent::gemini::tests::extract_response_from_stream_json ... ok
[INFO] [stdout] test agent::gemini::tests::parses_message_event_new_format ... ok
[INFO] [stdout] test agent::gemini::tests::parses_tool_call_event_from_function_call_object ... ok
[INFO] [stdout] test agent::gemini::tests::parses_turn_complete_with_tokens ... ok
[INFO] [stdout] test agent::gemini::tests::parses_tool_call_event_from_alternate_name_fields ... ok
[INFO] [stdout] test agent::gemini::tests::parses_tool_result_test_event ... ok
[INFO] [stdout] test agent::gemini::tests::test_extract_tokens_new_format ... ok
[INFO] [stdout] test agent::gemini::tests::parses_text_event ... ok
[INFO] [stdout] test agent::kilo::tests::build_command_includes_auto_flag ... ok
[INFO] [stdout] test agent::gemini::tests::parses_result_event_new_format ... ok
[INFO] [stdout] test agent::gemini::tests::skips_user_message_event ... ok
[INFO] [stdout] test agent::gemini::tests::test_extract_model ... ok
[INFO] [stdout] test agent::kilo::tests::build_command_includes_context_files ... ok
[INFO] [stdout] test agent::kilo::tests::build_command_includes_session_flags ... ok
[INFO] [stdout] test agent::kilo::tests::build_command_sets_current_dir_when_dir_provided ... ok
[INFO] [stdout] test agent::opencode::tests::build_command_includes_file_flags_for_context_files ... ok
[INFO] [stdout] test agent::opencode::tests::build_command_read_only_prepends_readonly_prefix ... ok
[INFO] [stdout] test agent::opencode::tests::codex_does_not_need_pty ... ok
[INFO] [stdout] test agent::opencode::tests::extracts_session_id_from_json_event ... ok
[INFO] [stdout] test agent::opencode::tests::no_session_flags_when_session_id_absent ... ok
[INFO] [stdout] test agent::opencode::tests::opencode_needs_pty ... ok
[INFO] [stdout] test agent::opencode::tests::parses_step_finish_token_event ... ok
[INFO] [stdout] test agent::opencode::tests::session_flags_appear_in_command ... ok
[INFO] [stdout] test agent::oz::tests::build_command_uses_oz ... ok
[INFO] [stdout] test agent::oz::tests::build_command_with_dir ... ok
[INFO] [stdout] test agent::oz::tests::parses_agent_reasoning_event ... ok
[INFO] [stdout] test agent::oz::tests::parses_tool_call_event ... ok
[INFO] [stdout] test agent::registry::tests::resolve_returns_none_for_unknown ... ok
[INFO] [stdout] test agent::selection::tests::cost_efficiency_calculates_ratio ... ok
[INFO] [stdout] test agent::registry::tests::empty_dir_returns_empty_registry ... ok
[INFO] [stdout] test agent::registry::tests::loads_valid_toml ... ok
[INFO] [stdout] test agent::registry::tests::skips_invalid_toml ... ok
[INFO] [stdout] test agent::registry::tests::list_returns_sorted ... ok
[INFO] [stdout] test agent::selection::tests::budget_mode_prefers_kilo_for_simple_edits ... ok
[INFO] [stdout] test agent::selection::tests::frontend_tasks_go_to_cursor ... ok
[INFO] [stdout] test agent::selection::tests::custom_agent_strengths_boost_score ... ok
[INFO] [stdout] test agent::selection::tests::custom_agent_scores_are_considered ... ok
[INFO] [stdout] test agent::selection::tests::budget_mode_avoids_codex_for_complex_tasks ... ok
[INFO] [stdout] test agent::selection::tests::complex_tasks_go_to_codex ... ok
[INFO] [stdout] test agent::selection::tests::custom_strengths_not_matching_category ... ok
[INFO] [stdout] test agent::selection::tests::history_appears_in_reason ... ok
[INFO] [stdout] test agent::selection::tests::history_ignored_for_low_task_count ... ok
[INFO] [stdout] test agent::selection::tests::history_bonus_for_high_success_rate ... ok
[INFO] [stdout] test agent::selection::tests::history_penalty_for_low_success_rate ... ok
[INFO] [stdout] test agent::selection::tests::history_prefers_high_success_rate_over_base_score ... ok
[INFO] [stdout] test agent::selection::tests::history_penalty_overrides_default_codex_selection ... ok
[INFO] [stdout] test agent::selection::tests::research_tasks_go_to_gemini ... ok
[INFO] [stdout] test agent::selection::tests::similar_tasks_hint_absent_without_history ... ok
[INFO] [stdout] test agent::selection::tests::team_override_boosts_score ... ok
[INFO] [stdout] test agent::selection::tests::simple_edits_go_to_opencode ... ok
[INFO] [stdout] test agent::selection::tests::team_preferred_agents_boost ... ok
[INFO] [stdout] test agent::selection::tests::team_does_not_block_non_preferred ... ok
[INFO] [stdout] test agent::tests::apply_run_env_sets_aid_home_on_command ... ok
[INFO] [stdout] test agent::selection::tests::team_default_agent_tiebreaker ... ok
[INFO] [stdout] test agent::selection::tests::similar_tasks_hint_appended ... ok
[INFO] [stdout] test agent::tests::apply_run_env_forwards_parent_vars ... ok
[INFO] [stdout] test agent::tests::reports_forwarded_env_for_subprocess ... ignored
[INFO] [stdout] test agent::tests::reports_is_rust_project_for_subprocess ... ignored
[INFO] [stdout] test agent::tests::reports_shared_target_dir_for_subprocess ... ignored
[INFO] [stdout] test agent::tests::returns_false_when_manifest_is_missing ... ok
[INFO] [stdout] test agent::tests::detects_rust_project_from_explicit_dir ... ok
[INFO] [stdout] test agent::tests::set_git_ceiling_uses_parent_dir ... ok
[INFO] [stdout] test agent::selection::tests::team_override_overrides_base_score ... ok
[INFO] [stdout] test agent::tests::apply_run_env_sets_explicit_vars_on_command ... ok
[INFO] [stdout] test agent::tests::target_dir_for_worktree_isolates_branches ... ok
[INFO] [stdout] test agent::truncate::tests::truncates_chinese_at_a_safe_boundary ... ok
[INFO] [stdout] test agent::truncate::tests::truncates_curly_quotes_at_a_safe_boundary ... ok
[INFO] [stdout] test agent::truncate::tests::truncates_emoji_at_a_safe_boundary ... ok
[INFO] [stdout] test agent::tests::shared_target_dir_prefers_explicit_env_var ... ok
[INFO] [stdout] test agent::tests::detects_rust_project_in_current_dir ... ok
[INFO] [stdout] test agent_config::tests::model_and_idle_timeout_coexist ... ok
[INFO] [stdout] test agent_config::tests::clearing_default_model_removes_agent_entry ... ok
[INFO] [stdout] test background::background_spec::tests::background_run_spec_defaults_read_only_to_false_when_missing ... ok
[INFO] [stdout] test background::background_spec::tests::background_run_spec_round_trips_read_only ... ok
[INFO] [stdout] test agent_config::tests::save_and_load_default_model_roundtrip ... ok
[INFO] [stdout] test background::tests::agent_pid_backwards_compatible ... ok
[INFO] [stdout] test agent::tests::shared_target_dir_defaults_under_aid_home ... ok
[INFO] [stdout] test agent::tests::shared_target_dir_defaults_to_home_aid_path ... ok
[INFO] [stdout] test agent::selection::tests::unavailable_primary_agent_falls_back_to_next_best ... ok
[INFO] [stdout] test background::tests::agent_pid_stored_and_loaded_correctly ... ok
[INFO] [stdout] test agent_config::tests::save_and_load_idle_timeout_roundtrip ... ok
[INFO] [stdout] test background::tests::build_on_done_command_does_not_expand_shell_operators ... ok
[INFO] [stdout] test background::tests::build_on_done_command_splits_simple_argv ... ok
[INFO] [stdout] test background::tests::explicit_cascade_takes_priority_over_quota_cascade ... ok
[INFO] [stdout] test background::tests::completion_notifications_are_written_as_jsonl ... ok
[INFO] [stdout] test agent::selection::tests::fallback_chain_skips_rate_limited ... FAILED
[INFO] [stdout] test agent::selection::tests::gemini_in_fallback_chain ... FAILED
[INFO] [stdout] test background::tests::quota_cascade_skipped_for_batch_tasks ... ok
[INFO] [stdout] test background::tests::serializes_cascade_field ... ok
[INFO] [stdout] test background::tests::serializes_spec_to_json ... ok
[INFO] [stdout] test background::tests::check_worker_capacity_warns_at_soft_limit ... ok
[INFO] [stdout] test background::tests::check_worker_capacity_rejects_at_hard_limit ... ok
[INFO] [stdout] test background::tests::marks_running_background_tasks_failed_when_worker_is_missing ... ok
[INFO] [stdout] test background::tests::keeps_recent_pending_tasks_pending ... ok
[INFO] [stdout] test background::tests::stale_pending_timeout_skips_tasks_that_already_moved_out_of_pending ... ok
[INFO] [stdout] test background::tests::check_zombie_tasks_auto_fails_old_running_tasks ... ok
[INFO] [stdout] test batch::tests::accepts_comma_separated_fallback ... ok
[INFO] [stdout] test batch::tests::accepts_task_singular_alias ... ok
[INFO] [stdout] test batch::tests::accepts_single_unnamed_task_with_worktree ... ok
[INFO] [stdout] test batch::tests::accepts_tasks_plural_alias ... ok
[INFO] [stdout] test batch::tests::accepts_valid_fallback_agent ... ok
[INFO] [stderr] [aid] Warning: task 'task-b' shares worktree 'feat/x' with 'task-a'; auto-sequencing execution.
[INFO] [stdout] test batch::tests::accepts_valid_sections ... ok
[INFO] [stdout] test batch::tests::auto_sequence_preserves_existing_depends_on ... ok
[INFO] [stdout] test background::tests::stale_pending_timeout_uses_agent_starting_reason_when_agent_pid_exists ... ok
[INFO] [stderr] [aid] Warning: task 'task-b' shares worktree 'feat/x' with 'task-a'; auto-sequencing execution.
[INFO] [stdout] test batch::tests::auto_sequences_shared_worktree_tasks ... ok
[INFO] [stderr] [aid] Warning: task 'b' shares worktree 'feat/x' with 'a'; auto-sequencing execution.
[INFO] [stderr] [aid] Warning: task 'c' shares worktree 'feat/x' with 'b'; auto-sequencing execution.
[INFO] [stdout] test batch::tests::auto_sequence_three_tasks_creates_chain ... ok
[INFO] [stdout] test batch::tests::cli_vars_override_toml_vars ... ok
[INFO] [stdout] test batch::tests::context_accepts_array ... ok
[INFO] [stdout] test batch::tests::context_accepts_string ... ok
[INFO] [stdout] test batch::tests::applies_defaults_to_tasks ... ok
[INFO] [stdout] test batch::tests::defaults_group_does_not_override_task_group ... ok
[INFO] [stdout] test batch::tests::defaults_group_parsed ... ok
[INFO] [stdout] test batch::tests::different_dirs_no_warning ... ok
[INFO] [stdout] test batch::tests::does_not_warn_for_audit_log_prompt ... ok
[INFO] [stdout] test batch::tests::does_not_warn_on_normal_prompt ... ok
[INFO] [stdout] test batch::tests::does_not_warn_when_read_only_is_true ... ok
[INFO] [stdout] test batch::tests::empty_defaults_do_not_change_existing_behavior ... ok
[INFO] [stdout] test batch::tests::interpolates_task_vars_in_prompt_dir_and_worktree ... ok
[INFO] [stdout] test batch::tests::judge_absent_is_none ... ok
[INFO] [stdout] test batch::tests::judge_defaults_propagate_to_tasks ... ok
[INFO] [stdout] test batch::tests::context_from_creates_implicit_dependency ... ok
[INFO] [stdout] test batch::tests::context_from_deduplicates_with_explicit_depends_on ... ok
[INFO] [stdout] test batch::tests::judge_false_is_none ... ok
[INFO] [stdout] test batch::tests::judge_true_defaults_to_gemini ... ok
[INFO] [stdout] test batch::tests::judge_string_uses_specified_agent ... ok
[INFO] [stdout] test batch::tests::mixed_worktree_no_warning_for_isolated ... ok
[INFO] [stdout] test batch::tests::missing_var_warns_without_failing ... ok
[INFO] [stdout] test batch::tests::no_vars_section_keeps_existing_behavior ... ok
[INFO] [stdout] test batch::tests::no_warning_when_worktree_set ... ok
[INFO] [stdout] test background::tests::marks_stale_pending_tasks_failed ... ok
[INFO] [stdout] test batch::tests::rejects_dependency_cycles ... ok
[INFO] [stdout] test batch::tests::parse_valid_batch ... ok
[INFO] [stdout] test batch::tests::rejects_empty_batch ... ok
[INFO] [stdout] test batch::tests::parses_batch_with_dependencies ... ok
[INFO] [stdout] test batch::tests::no_warning_on_normal_prompt_size ... ok
[INFO] [stdout] test batch::tests::rejects_missing_agent_without_defaults ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_agent ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_defaults_field ... ok
[INFO] [stdout] test background::tests::zombie_cleanup_skips_autocommit_for_read_only ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_fallback_agent ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_task_field ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_top_level_key ... ok
[INFO] [stdout] test batch::tests::rejects_unnamed_tasks_sharing_worktree ... ok
[INFO] [stdout] test background::tests::stale_pending_timeout_uses_rate_limited_reason ... ok
[INFO] [stdout] test batch::tests::warns_on_audit_prompt_without_read_only ... ok
[INFO] [stdout] test batch::tests::single_task_no_warning ... ok
[INFO] [stdout] test batch::tests::warns_on_large_prompt ... ok
[INFO] [stdout] test batch::tests::worktree_prefix_generates_worktree_for_unnamed_tasks ... ok
[INFO] [stdout] test batch::tests::worktree_prefix_prefers_name_over_index ... ok
[INFO] [stdout] test batch::tests::rejects_unknown_section ... ok
[INFO] [stdout] test batch::tests::task_values_override_defaults ... ok
[INFO] [stdout] test batch::tests::warns_on_dir_overlap_without_worktree ... ok
[INFO] [stdout] test background::tests::stale_pending_timeout_uses_worker_capacity_reason ... ok
[INFO] [stdout] test board::tests::board_shows_awaiting_input_reason ... ok
[INFO] [stdout] test batch::tests::rejects_invalid_dependency_reference ... ok
[INFO] [stdout] test board::tests::task_detail_rendering ... ok
[INFO] [stdout] test board::tests::task_detail_shows_pending_reason ... ok
[INFO] [stdout] test board::tests::task_detail_shows_retry_chain ... ok
[INFO] [stdout] test claudemd::tests::optional_fields_omitted ... ok
[INFO] [stdout] test claudemd::tests::read_returns_none_without_file ... ok
[INFO] [stdout] test claudemd::tests::read_returns_section ... ok
[INFO] [stdout] test claudemd::tests::sync_appends_to_existing ... ok
[INFO] [stdout] test claudemd::tests::sync_creates_new_claude_md ... ok
[INFO] [stdout] test claudemd::tests::sync_preserves_surrounding_content ... ok
[INFO] [stdout] test board::tests::board_shows_latest_error_for_failed_task ... ok
[INFO] [stdout] test board::tests::empty_board ... ok
[INFO] [stdout] test cli::tests::bare_aid_parses_without_subcommand ... ok
[INFO] [stdout] test cli::tests::batch_retry_parses ... ok
[INFO] [stdout] test cli::tests::batch_dispatch_file_parses ... ok
[INFO] [stdout] test cli::tests::changelog_git_flag_parses ... ok
[INFO] [stdout] test board::tests::board_shows_running_task_milestone ... ok
[INFO] [stdout] test board::tests::board_with_tasks ... ok
[INFO] [stdout] test cli::tests::changelog_version_parses ... ok
[INFO] [stdout] test cli::tests::experiment_run_parses ... ok
[INFO] [stdout] test cli::tests::run_best_of_flag_parses ... ok
[INFO] [stdout] test cli::tests::run_container_flag_parses ... ok
[INFO] [stdout] test claudemd::tests::sync_updates_existing_section ... ok
[INFO] [stdout] test board::tests::board_shows_repo_column_when_present ... ok
[INFO] [stdout] test cli::tests::run_idle_timeout_flag_parses ... ok
[INFO] [stdout] test cli::tests::run_peer_review_flag_parses ... ok
[INFO] [stdout] test cli::tests::run_parent_flag_parses ... ok
[INFO] [stdout] test cli::tests::container_subcommand_parses ... ok
[INFO] [stdout] test cli::tests::run_timeout_flag_parses ... ok
[INFO] [stdout] test cli::tests::hook_session_start_parses ... ok
[INFO] [stdout] test board::tests::board_shows_pending_reason_for_failed_pending_timeout ... ok
[INFO] [stdout] test cli::tests::show_diff_file_flag_parses ... ok
[INFO] [stdout] test cli::tests::run_sandbox_flag_parses ... ok
[INFO] [stdout] test cmd::agent::tests::show_quota_runs_without_panic ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_detects_overlapping_context_files ... ok
[INFO] [stdout] test cli::tests::show_summary_flag_parses ... ok
[INFO] [stdout] test cli::tests::watch_timeout_flag_parses ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_detects_json_paths_in_prompt ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_detects_md_paths_in_prompt ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_detects_overlapping_output_files ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_ignores_tasks_with_dependency ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_extracts_paths_from_prompt ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_skips_context_for_read_only_tasks ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_output_overlap_ignored_with_dependency ... ok
[INFO] [stdout] test cmd::batch::batch_init::tests::render_template_with_no_project ... ok
[INFO] [stdout] test cmd::batch::batch_init::tests::render_template_with_project_defaults ... ok
[INFO] [stdout] test cmd::batch::batch_output_dedup::tests::dedup_preserves_non_conflicting ... ok
[INFO] [stdout] test cmd::batch::batch_output_dedup::tests::dedup_handles_path_with_directory ... ok
[INFO] [stdout] test cmd::batch::batch_output_dedup::tests::dedup_handles_unnamed_tasks ... ok
[INFO] [stdout] test cmd::batch::batch_init::tests::init_refuses_existing_file ... ok
[INFO] [stdout] test cmd::batch::batch_analyze::tests::analyze_no_false_positives_on_urls ... ok
[INFO] [stdout] test cmd::batch::batch_output_dedup::tests::dedup_renames_parallel_conflicts ... ok
[INFO] [stdout] test cmd::batch::batch_output_dedup::tests::dedup_skips_sequential_tasks ... ok
[INFO] [stdout] test cmd::batch::batch_retry::tests::retry_unchanged_for_unknown_agent ... ok
[INFO] [stdout] test cmd::batch::batch_retry::tests::retry_uses_original_when_not_rate_limited ... ok
[INFO] [stdout] test cmd::batch::batch_init::tests::init_creates_file ... ok
[INFO] [stdout] test cmd::batch::batch_retry::tests::retry_uses_override_regardless_of_rate_limit ... ok
[INFO] [stdout] test background::tests::is_process_running_returns_false_for_zombie ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::resolve_batch_path_uses_aid_batches_fallback ... ok
[INFO] [stdout] test cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited ... FAILED
[INFO] [stdout] test cmd::batch::batch_tests::retry::retry_task_to_run_args_prefers_existing_worktree_path ... ok
[INFO] [stdout] test cmd::batch::batch_tests::retry::retry_task_to_run_args_uses_parent_and_original_fields ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::batch_summary_skips_zero_cost_and_uses_seconds_under_minute ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::ensure_batch_workgroup_reuses_existing_default_group ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::batch_summary_formats_cost_and_time ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::ensure_batch_workgroup_creates_missing_default_group ... ok
[INFO] [stdout] test cmd::batch::batch_tests::retry::retry_failed_returns_ok_when_no_failed_tasks_exist ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::ensure_batch_workgroup_creates_shared_dir_when_enabled ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_applies_forwarded_env_after_explicit_env ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_copies_checklist ... ok
[INFO] [stdout] test cmd::batch::batch_tests::trigger::trigger_failure_marks_target ... ok
[INFO] [stdout] test cmd::batch::batch_tests::trigger::trigger_success_marks_target ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_copies_context ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_copies_existing_task_id_and_run_flags ... ok
[INFO] [stdout] test cmd::batch::batch_validate::tests::test_rate_limit_precheck_does_not_panic ... ok
[INFO] [stdout] test cmd::batch::batch_tests::helpers::batch_group_flag_assigns_existing_workgroup ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_includes_shared_dir_env ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_defaults_dry_run_to_false ... ok
[INFO] [stdout] test cmd::batch_auto_fallback_tests::pre_dispatch_keeps_original_when_no_fallback_is_available ... ok
[INFO] [stdout] test cmd::batch_auto_fallback_tests::pre_dispatch_uses_fallback_when_agent_is_rate_limited ... ok
[INFO] [stdout] test cmd::benchmark::tests::format_duration_uses_whole_seconds ... ok
[INFO] [stdout] test cmd::benchmark::tests::parse_agents_trims_and_requires_values ... ok
[INFO] [stdout] test cmd::board::tests::board_json_row_includes_pending_reason ... ok
[INFO] [stdout] test cmd::board::tests::board_with_limit_truncates_output ... ok
[INFO] [stdout] test cmd::board::tests::long_running_warning_counts_running_tasks_older_than_one_hour ... ok
[INFO] [stdout] test cmd::changelog::tests::extracts_embedded_section_for_version ... ok
[INFO] [stdout] test cmd::changelog::tests::renders_version_sections ... ok
[INFO] [stdout] test cmd::changelog::tests::selects_specific_version_without_v_prefix ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::all_confirmed_all_addressed ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::case_insensitive_keywords ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::checkbox_x_marked_confirmed ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::empty_checklist_all_addressed ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::mixed_confirmed_rejected_all_addressed ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::numbered_bracket_line_then_confirmed ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::one_missing_reported ... ok
[INFO] [stdout] test cmd::checklist_scan::tests::summary_counts ... ok
[INFO] [stdout] test cmd::config::tests::loads_and_merges_pricing_overrides ... ok
[INFO] [stdout] test cmd::cost_tests::aggregates_daily_summary_rows ... ok
[INFO] [stdout] test cmd::cost_tests::aggregates_group_costs ... ok
[INFO] [stdout] test cmd::cost_tests::empty_workgroup_returns_no_tasks ... ok
[INFO] [stdout] test cmd::batch::batch_tests::run_args::task_to_run_args_includes_sibling_metadata ... ok
[INFO] [stdout] test cmd::batch::batch_validate::tests::find_ready_dispatches_when_individual_dep_satisfied ... ok
[INFO] [stdout] test cmd::batch_auto_fallback_tests::should_auto_fallback_only_once_for_failed_tasks ... ok
[INFO] [stdout] test cmd::eta::tests::format_eta_formats_correctly ... ok
[INFO] [stdout] test cmd::experiment_persist::tests::load_missing_file_returns_empty ... ok
[INFO] [stdout] test cmd::experiment_persist::tests::save_and_load_roundtrip ... ok
[INFO] [stdout] test cmd::experiment_types::tests::is_improvement_first_run_always_true ... ok
[INFO] [stdout] test cmd::experiment_types::tests::is_improvement_max_direction ... ok
[INFO] [stdout] test cmd::experiment_types::tests::is_improvement_min_direction ... ok
[INFO] [stdout] test cmd::experiment_types::tests::record_run_updates_best ... ok
[INFO] [stdout] test cmd::explain::tests::explain_prompt_embeds_execution_context ... ok
[INFO] [stdout] test cmd::batch::batch_tests::trigger::conditional_task_stays_dormant_until_triggered ... ok
[INFO] [stdout] test cmd::finding::finding_render::tests::human_output_for_empty_findings_is_unchanged ... ok
[INFO] [stdout] test cmd::batch_auto_fallback_tests::auto_fallback_skips_rate_limited_toml_fallbacks ... ok
[INFO] [stdout] test cmd::batch::batch_validate::tests::find_ready_skips_tasks_with_failed_deps ... ok
[INFO] [stdout] test cmd::cost_tests::run_accepts_empty_group_report ... ok
[INFO] [stdout] test cmd::finding::tests::normalize_optional_verdict_accepts_known_values ... ok
[INFO] [stdout] test cmd::eta::tests::estimate_eta_returns_none_without_history ... ok
[INFO] [stdout] test cmd::eta::tests::estimate_eta_returns_remaining_time ... ok
[INFO] [stdout] test cmd::finding::tests::normalize_optional_verdict_rejects_unknown_values ... ok
[INFO] [stdout] test cmd::finding::tests::parse_score_json_normalizes_valid_payloads ... ok
[INFO] [stdout] test cmd::hook::tests::renders_base_text_without_project ... ok
[INFO] [stdout] test cmd::hook::tests::renders_project_and_combined_rule_count ... ok
[INFO] [stdout] test cmd::judge::tests::parse_empty_response_defaults_to_pass ... ok
[INFO] [stdout] test cmd::judge::tests::parse_first_line_retry ... ok
[INFO] [stdout] test cmd::judge::tests::parse_first_line_pass ... ok
[INFO] [stdout] test cmd::judge::tests::parse_no_verdict_defaults_to_pass ... ok
[INFO] [stdout] test cmd::finding::finding_render::tests::human_output_lists_findings_in_existing_format ... ok
[INFO] [stdout] test cmd::judge::tests::parse_peer_review_no_score_defaults_to_5 ... ok
[INFO] [stdout] test cmd::judge::tests::parse_peer_review_extracts_score ... ok
[INFO] [stdout] test cmd::judge::tests::parse_verdict_after_prose ... ok
[INFO] [stdout] test cmd::judge::tests::parse_retry_after_reasoning ... ok
[INFO] [stdout] test cmd::judge::tests::truncate_diff_at_newline_boundary ... ok
[INFO] [stdout] test cmd::judge::tests::truncate_diff_within_limit ... ok
[INFO] [stdout] test cmd::mcp::tests::reads_content_length_messages ... ok
[INFO] [stdout] test cmd::mcp::tests::reads_json_line_messages ... ok
[INFO] [stdout] test cmd::memory::tests::accepts_non_obvious_behavior ... ok
[INFO] [stdout] test cmd::memory::tests::accepts_performance_notes ... ok
[INFO] [stdout] test cmd::memory::tests::rejects_discovery_signatures ... ok
[INFO] [stdout] test cmd::memory::tests::accepts_real_discoveries ... ok
[INFO] [stdout] test cmd::memory::tests::rejects_common_boilerplate ... ok
[INFO] [stdout] test cmd::finding::finding_render::tests::detailed_human_output_shows_review_metadata ... ok
[INFO] [stdout] test cmd::memory::tests::rejects_trivial_length ... ok
[INFO] [stdout] test cmd::merge::merge_git::merge_verify::tests::verify_argv_split_keeps_shell_tokens_literal ... ok
[INFO] [stdout] test cmd::merge::tests::approval_decision_defaults_to_merge ... ok
[INFO] [stdout] test cmd::finding::finding_render::tests::single_finding_json_output_includes_review_fields ... ok
[INFO] [stdout] test cmd::batch_auto_fallback_tests::auto_fallback_agent_returns_none_when_chain_ends ... ok
[INFO] [stdout] test cmd::finding::finding_render::tests::json_output_includes_review_fields ... ok
[INFO] [stdout] test cmd::mcp::tests::dispatches_board_tool_calls ... ok
[INFO] [stdout] test cmd::merge::tests::commits_ahead_returns_zero_for_missing_branch ... ok
[INFO] [stdout] test cmd::merge::tests::checkout_branch_switches_head ... ok
[INFO] [stdout] test cmd::merge::tests::commits_ahead_returns_zero_for_same_head ... ok
[INFO] [stdout] test cmd::merge::tests::auto_commit_uncommitted_commits_dirty_worktree ... ok
[INFO] [stdout] test cmd::merge::tests::auto_commit_message_includes_filename ... ok
[INFO] [stdout] test cmd::merge::tests::auto_commit_uncommitted_returns_false_for_clean_worktree ... ok
[INFO] [stdout] test cmd::merge::tests::check_merge_detects_conflict ... ok
[INFO] [stdout] test cmd::merge::tests::commits_ahead_detects_branch_with_commits ... ok
[INFO] [stdout] test cmd::merge::tests::git_merge_branch_detects_already_up_to_date ... ok
[INFO] [stdout] test cmd::merge::tests::check_merge_detects_clean_merge ... ok
[INFO] [stdout] test cmd::merge::tests::git_merge_branch_detects_conflict ... ok
[INFO] [stdout] test cmd::merge::tests::git_merge_branch_merges_committed_branch ... ok
[INFO] [stdout] test cmd::merge::tests::git_merge_branch_stashes_and_warns_on_pop_conflict ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_auto_commits_then_merges ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_rejects_non_done_task ... ok
[INFO] [stdout] test cmd::merge::tests::git_merge_branch_stashes_local_changes ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_merges_into_target_branch ... ok
[INFO] [stdout] test cmd::merge::tests::remove_worktree_cleans_up_properly ... ok
[INFO] [stdout] test cmd::merge::tests::remove_worktree_refuses_unsafe_path ... ok
[INFO] [stdout] test cmd::merge::tests::resolve_repo_dir_falls_back_to_dot ... ok
[INFO] [stdout] test cmd::merge::tests::resolve_repo_dir_prefers_explicit_repo_path ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_works_without_worktree_branch ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_without_repo_path_resolves_from_worktree ... ok
[INFO] [stdout] test cmd::merge::tests::sandbox_allows_aid_worktree_paths ... ok
[INFO] [stdout] test cmd::merge::tests::sandbox_blocks_non_worktree_paths ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_fails_when_no_commits_and_no_changes ... ok
[INFO] [stdout] test cmd::project::state_command::tests::render_state_includes_requested_sections ... ok
[INFO] [stdout] test cmd::merge::tests::resolve_repo_dir_detects_from_worktree ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_preserves_worktree_on_conflict ... ok
[INFO] [stdout] test cmd::merge::tests::run_post_merge_verify_warns_on_failure ... ok
[INFO] [stdout] test cmd::retry_logic::tests::backoff_for_attempt_increases ... ok
[INFO] [stdout] test cmd::retry::tests::reset_dirty_worktree_discards_dirty_files ... ok
[INFO] [stdout] test cmd::retry_logic::tests::test_backoff_capped ... ok
[INFO] [stdout] test cmd::merge::tests::merge_group_skips_empty_branches ... ok
[INFO] [stdout] test cmd::retry::tests::clean_worktree_is_not_modified ... ok
[INFO] [stdout] test cmd::run::checklist_tests::background_run_spec_round_trips_checklist_via_serde ... ok
[INFO] [stdout] test cmd::retry_logic::tests::test_root_prompt_walks_chain ... ok
[INFO] [stdout] test cmd::run::checklist_tests::checklist_file_loading_skips_comments_and_blank_lines ... ok
[INFO] [stdout] test cmd::retry_logic::tests::retry_depth_is_zero_without_parent ... ok
[INFO] [stdout] test cmd::retry_logic::tests::test_retry_depth_with_chain ... ok
[INFO] [stdout] test cmd::run::run_agent::tests::write_streaming_output_does_not_duplicate_streamed_message_when_final_message_matches ... ok
[INFO] [stdout] test cmd::run::run_agent::tests::spawn_child_with_log_writes_error_event_when_spawn_fails ... ok
[INFO] [stdout] test cmd::run::run_agent::tests::write_streaming_output_keeps_last_five_substantive_messages ... ok
[INFO] [stdout] test cmd::merge::tests::run_verify_handles_auto_without_error ... ok
[INFO] [stdout] test cmd::run::run_bestof::tests::pick_best_result_none_when_no_done ... ok
[INFO] [stdout] test cmd::run::run_bestof::tests::best_of_count_validation ... ok
[INFO] [stdout] test cmd::run::run_bestof::tests::pick_best_result_prefers_longest_diff ... ok
[INFO] [stdout] test cmd::run::run_bestof::tests::pick_best_result_prefers_metric_score ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::extract_words_filters_stop_words ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::format_entry_block_truncates_long_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::format_entry_block_with_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::format_entry_block_without_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::format_knowledge_block_header ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::format_knowledge_block_multiple ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::extract_words_basic ... ok
[INFO] [stdout] test cmd::run::checklist_tests::checklist_items_are_injected_into_prompt_with_required_format ... ok
[INFO] [stdout] test cmd::run::run_agent::tests::write_streaming_output_skips_writing_when_messages_are_not_substantive ... ok
[INFO] [stdout] test cmd::retry::tests::save_partial_work_commits_dirty_files ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::sanitize_preserves_normal_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::sanitize_strips_aid_tags ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::select_relevant_entries_empty_prompt ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::select_relevant_entries_filters_zero_score ... ok
[INFO] [stdout] test cmd::run::checklist_tests::empty_checklist_produces_no_prompt_injection ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::select_relevant_entries_ranks_by_overlap ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::select_relevant_entries_caps_at_5 ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::select_relevant_entries_requires_two_word_overlap ... ok
[INFO] [stdout] test cmd::run::run_prompt::run_output::tests::fill_empty_output_from_log_creates_missing_output_file ... ok
[INFO] [stdout] test cmd::run::run_prompt::run_output::tests::fill_empty_output_from_log_extracts_full_text_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::resolve_context_from_wraps_in_fence ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::resolve_context_from_prefers_extracted_log_messages ... ok
[INFO] [stdout] test cmd::run::run_prompt::prompt_context::tests::resolve_context_from_reads_shared_file ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_includes_output_instruction_when_output_is_set ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_includes_git_staging_guard_for_writable_tasks ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_appends_batch_siblings_after_system_context ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_includes_shared_dir_instruction_when_env_is_set ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::clean_output_if_jsonl_cleans_jsonl_file ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_includes_sibling_context_for_codex ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_skips_sibling_context_for_kilo ... ok
[INFO] [stdout] test cmd::merge::tests::sync_cargo_lock_before_merge_commits_updated_lockfile ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_omits_output_instruction_when_output_is_not_set ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::clean_output_if_jsonl_preserves_mixed_content ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::effective_skills_auto_apply_defaults ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::effective_skills_respect_no_skill_sentinel ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::extract_words_normalizes_keywords ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_skips_sibling_context_for_opencode ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::build_prompt_bundle_omits_git_staging_guard_for_read_only_tasks ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::fill_empty_output_from_log_populates_zero_byte_file ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::format_batch_siblings_truncates_and_limits_output ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::clean_output_if_jsonl_preserves_normal_text ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::fill_empty_output_from_log_keeps_existing_output ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::sanitize_strips_structural_tags ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::fill_empty_output_from_log_falls_back_to_raw_text ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::sanitize_preserves_normal_lines ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::skill_tests::inject_skill_skips_methodology_for_short_prompts ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::skill_tests::inject_skill_includes_gotchas_scripts_and_references_for_folder_skill ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::load_workgroup_auto_creates_when_not_found ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::load_workgroup_returns_existing_workgroup ... ok
[INFO] [stdout] test cmd::merge::tests::merge_single_succeeds_with_committed_worktree ... ok
[INFO] [stdout] test cmd::run::tests::read_quota_error_message_detects_402_payment_errors ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::load_workgroup_returns_none_when_group_id_is_none ... ok
[INFO] [stdout] test cmd::run::tests::read_quota_error_message_extracts_rate_limit_line_only ... ok
[INFO] [stdout] test cmd::run::tests::read_quota_error_message_falls_back_to_log ... ok
[INFO] [stdout] test cmd::run::tests::read_quota_error_message_uses_stderr ... ok
[INFO] [stdout] test cmd::run::tests::dry_run_returns_without_starting_task ... ok
[INFO] [stdout] test cmd::run::tests::auto_save_creates_output_for_research_task ... ok
[INFO] [stdout] test cmd::run::tests::rescue_quota_failed_task_keeps_failed_verify_failed ... ok
[INFO] [stdout] test cmd::run::tests::rescue_quota_failed_task_marks_passed_verify_as_done ... ok
[INFO] [stdout] test cmd::run::tests::empty_diff_detection_respects_worktree_state ... ok
[INFO] [stdout] test cmd::run::tests::resolve_max_duration_mins_preserves_explicit_minutes ... ok
[INFO] [stdout] test cmd::run::tests::resolve_max_duration_mins_uses_timeout_when_minutes_missing ... ok
[INFO] [stdout] test cmd::run::tests::take_next_cascade_agent_consumes_first_entry ... ok
[INFO] [stdout] test cmd::run::tests::take_next_cascade_agent_returns_none_when_empty ... ok
[INFO] [stdout] test cmd::run::tests::validate_dispatch_skips_dir_warning_for_non_writing_tasks ... ok
[INFO] [stdout] test cmd::run::tests::validate_dispatch_warns_code_agent_without_dir ... ok
[INFO] [stdout] test cmd::run::tests::validate_dispatch_warns_long_prompt ... ok
[INFO] [stdout] test cmd::run::tests::validate_dispatch_warns_research_worktree ... ok
[INFO] [stdout] test cmd::run::tests::validate_dispatch_warns_short_prompt ... ok
[INFO] [stdout] test cmd::show::show_checklist_tests::extract_checklist_from_prompt_parses_items ... ok
[INFO] [stdout] test cmd::run::tests::rate_limited_agent_with_cascade_proceeds ... ok
[INFO] [stdout] test cmd::run::tests::resolve_id_conflict_blocks_running ... ok
[INFO] [stdout] test cmd::run::tests::resolve_id_conflict_auto_suffixes_terminal ... ok
[INFO] [stdout] test cmd::show::show_checklist_tests::render_all_confirmed_shows_checkmarks ... ok
[INFO] [stdout] test cmd::run::tests::rate_limited_agent_without_cascade_fails_early ... ok
[INFO] [stdout] test cmd::run::tests::resolve_id_conflict_none_for_missing_id ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_accumulates_cursor_assistant_deltas ... ok
[INFO] [stdout] test cmd::show::show_checklist_tests::render_without_checklist_returns_none ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_from_log_collects_supported_formats ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_from_log_caps_message_count_and_size ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_from_log_returns_none_without_supported_messages ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_full_skips_truncation ... ok
[INFO] [stdout] test cmd::run::tests::resolve_id_conflict_replace_waiting ... ok
[INFO] [stdout] test cmd::show::show_output::brief_tests::output_text_brief_truncates ... ok
[INFO] [stdout] test cmd::show::show_output::tests::extract_messages_research_relaxed_limits ... ok
[INFO] [stdout] test cmd::show::show_output::tests::parse_diff_stat_skips_binary_entries ... ok
[INFO] [stdout] test cmd::show::show_output::tests::parse_diff_stat_empty_text ... ok
[INFO] [stdout] test cmd::show::show_output::tests::parse_diff_stat_standard_line ... ok
[INFO] [stdout] test cmd::show::show_output::tests::tail_lines_keeps_only_requested_suffix ... ok
[INFO] [stdout] test cmd::show::show_output::tests::reads_task_output_file ... ok
[INFO] [stdout] test cmd::show::show_output::tests::truncate_conclusion_at_2000_chars ... ok
[INFO] [stdout] test cmd::show::show_checklist_tests::render_missing_item_shows_x ... ok
[INFO] [stdout] test cmd::show::show_output::tests::diff_text_falls_back_to_default_log_output ... ok
[INFO] [stdout] test cmd::show::show_output::brief_tests::output_text_defaults_to_full ... ok
[INFO] [stdout] test cmd::show::show_output::tests::output_text_uses_research_mode_for_no_worktree ... ok
[INFO] [stdout] test cmd::show::tests::context_text_reconstructs_skills_when_resolved_prompt_missing ... ok
[INFO] [stdout] test cmd::show::show_output::tests::output_text_for_task_prefers_extracted_messages_to_raw_log ... ok
[INFO] [stdout] test cmd::show::tests::context_text_prefers_stored_resolved_prompt ... ok
[INFO] [stdout] test cmd::stats::tests::render_output_shows_friendly_message_when_no_tasks_match ... ok
[INFO] [stdout] test cmd::show::tests::audit_text_shows_findings_for_research_task ... ok
[INFO] [stdout] test cmd::run::run_prompt::tests::extracted_tests::run_auto_retries_after_verify_failure ... ok
[INFO] [stdout] test cmd::stop::tests::preserve_worktree_attempts_commit_for_non_read_only ... ok
[INFO] [stdout] test cmd::stop::tests::preserve_worktree_skips_read_only_tasks ... ok
[INFO] [stdout] test cmd::stats::tests::collects_agent_failure_and_model_stats ... ok
[INFO] [stdout] test cmd::stats::tests::stats_does_not_panic_on_zero_duration_count ... ok
[INFO] [stdout] test cmd::stop::tests::stop_missing_task_returns_error ... ok
[INFO] [stdout] test cmd::stop::tests::stop_attempts_agent_cleanup_when_agent_pid_exists ... ok
[INFO] [stdout] test cmd::summary::tests::deserializes_missing_conclusion_as_empty ... ok
[INFO] [stdout] test cmd::summary::tests::extracts_files_from_diff ... ok
[INFO] [stdout] test cmd::summary::tests::format_sibling_summaries_empty_returns_empty ... ok
[INFO] [stdout] test cmd::summary::tests::format_sibling_summaries_renders_list ... ok
[INFO] [stdout] test cmd::stop::tests::stop_done_task_returns_error ... ok
[INFO] [stdout] test cmd::summary::tests::generates_conclusion_from_log_file_when_output_missing ... ok
[INFO] [stdout] test cmd::show::tests::task_json_includes_pending_reason ... ok
[INFO] [stdout] test cmd::summary::tests::format_summary_produces_readable_output ... ok
[INFO] [stdout] test cmd::steer::tests::steer_non_running_task_errors ... ok
[INFO] [stdout] test cmd::stop::tests::stop_running_task_sets_stopped ... ok
[INFO] [stdout] test cmd::summary::tests::generates_summary_from_task ... ok
[INFO] [stdout] test cmd::summary::tests::handles_no_diff_gracefully ... ok
[INFO] [stdout] test cmd::team::tests::delete_team_missing_name_error ... ok
[INFO] [stdout] test cmd::team::tests::create_team_happy_path ... ok
[INFO] [stdout] test cmd::team::tests::create_team_duplicate_name_error ... ok
[INFO] [stdout] test cmd::summary::tests::generates_conclusion_from_output_file ... ok
[INFO] [stdout] test cmd::team::tests::list_teams_no_teams ... ok
[INFO] [stdout] test cmd::team::tests::show_team_not_found_error ... ok
[INFO] [stdout] test cmd::team::tests::delete_team_happy_path ... ok
[INFO] [stdout] test cmd::team::tests::show_team_without_overrides ... ok
[INFO] [stdout] test cmd::team::tests::list_teams_multiple_entries ... ok
[INFO] [stdout] test cmd::show::tests::summary_text_shows_diff_stat_without_full_diff ... ok
[INFO] [stdout] test cmd::team::tests::show_team_with_overrides ... ok
[INFO] [stdout] test cmd::team::tests::title_case_variants ... ok
[INFO] [stdout] test cmd::tool::tests::add_tool_creates_toml ... ok
[INFO] [stdout] test cmd::tool::tests::add_team_tool_creates_in_team_dir ... ok
[INFO] [stdout] test cmd::tool::tests::add_tool_duplicate_errors ... ok
[INFO] [stdout] test cmd::tool::tests::show_tool_not_found_error ... ok
[INFO] [stdout] test cmd::tool::tests::remove_tool_deletes_file ... ok
[INFO] [stdout] test cmd::tool::tests::title_case_variants ... ok
[INFO] [stdout] test cmd::tool::tests::list_tools_no_tools ... ok
[INFO] [stdout] test cmd::tool::tests::remove_missing_tool_errors ... ok
[INFO] [stdout] test cmd::worktree::tests::should_prune_worktree_recent_path ... ok
[INFO] [stdout] test cmd::show::tests::summary_text_shows_conclusion_for_research_task ... ok
[INFO] [stdout] test cmd_dispatch::tests::resolve_finding_content_prefers_file ... ok
[INFO] [stdout] test cmd_dispatch::tests::resolve_finding_content_errors_without_input ... ok
[INFO] [stdout] test cmd_dispatch::tests::resolve_finding_content_reads_stdin_when_piped_without_arg ... ok
[INFO] [stdout] test cmd_dispatch::tests::resolve_finding_content_reads_stdin_when_requested ... ok
[INFO] [stdout] test cmd_dispatch::tests::resolve_finding_content_uses_inline_arg ... ok
[INFO] [stderr] hint: Using 'master' as the name for the initial branch. This default branch name
[INFO] [stderr] hint: is subject to change. To configure the initial branch name to use in all
[INFO] [stderr] hint: of your new repositories, which will suppress this warning, call:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git config --global init.defaultBranch <name>
[INFO] [stderr] hint: 
[INFO] [stderr] hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
[INFO] [stderr] hint: 'development'. The just-created branch can be renamed via this command:
[INFO] [stderr] hint: Using 'master' as the name for the initial branch. This default branch name
[INFO] [stdout] test cmd::worktree::tests::should_prune_worktree_old_path ... ok
[INFO] [stderr] hint: is subject to change. To configure the initial branch name to use in all
[INFO] [stderr] hint: of your new repositories, which will suppress this warning, call:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git config --global init.defaultBranch <name>
[INFO] [stderr] hint: 
[INFO] [stderr] hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
[INFO] [stderr] hint: 'development'. The just-created branch can be renamed via this command:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git branch -m <name>
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpn0YGB3/.git/
[INFO] [stdout] test cmd::wait::tests::wait_for_task_ids_completes_with_existing_milestone_event ... ok
[INFO] [stderr] hint: 
[INFO] [stdout] test cmd::tool::tests::show_and_test_team_tool_require_team_flag ... ok
[INFO] [stderr] hint: 	git branch -m <name>
[INFO] [stdout] test commit::tests::extract_task_summary_plain_prompt ... ok
[INFO] [stdout] test commit::tests::extract_task_summary_prefers_task_section ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpYEm6yT/.git/
[INFO] [stderr] hint: Using 'master' as the name for the initial branch. This default branch name
[INFO] [stdout] test cmd::wait::tests::wait_for_task_ids_times_out_with_running_tasks ... ok
[INFO] [stdout] test cmd::show::tests::audit_text_shows_pending_reason ... ok
[INFO] [stdout] test commit::tests::strip_aid_tags_passthrough_no_tags ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpyS6tDP/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpVmuTIm/.git/
[INFO] [stdout] test commit::tests::strip_aid_tags_removes_tag_blocks ... ok
[INFO] [stderr] hint: Using 'master' as the name for the initial branch. This default branch name
[INFO] [stderr] hint: is subject to change. To configure the initial branch name to use in all
[INFO] [stderr] hint: of your new repositories, which will suppress this warning, call:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git config --global init.defaultBranch <name>
[INFO] [stderr] hint: 
[INFO] [stderr] hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
[INFO] [stderr] hint: 'development'. The just-created branch can be renamed via this command:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git branch -m <name>
[INFO] [stderr] hint: Using 'master' as the name for the initial branch. This default branch name
[INFO] [stderr] hint: is subject to change. To configure the initial branch name to use in all
[INFO] [stderr] hint: of your new repositories, which will suppress this warning, call:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git config --global init.defaultBranch <name>
[INFO] [stderr] hint: 
[INFO] [stderr] hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
[INFO] [stderr] hint: 'development'. The just-created branch can be renamed via this command:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git branch -m <name>
[INFO] [stderr] hint: is subject to change. To configure the initial branch name to use in all
[INFO] [stderr] hint: of your new repositories, which will suppress this warning, call:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git config --global init.defaultBranch <name>
[INFO] [stderr] hint: 
[INFO] [stderr] hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
[INFO] [stderr] hint: 'development'. The just-created branch can be renamed via this command:
[INFO] [stderr] hint: 
[INFO] [stderr] hint: 	git branch -m <name>
[INFO] [stdout] test compaction::tests::compact_to_budget_leaves_short_text ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpmSGYa3/.git/
[INFO] [stdout] test compaction::tests::compact_to_budget_truncates_and_marks ... ok
[INFO] [stdout] test commit::tests::detects_dirty_git_repo ... ok
[INFO] [stdout] test commit::tests::auto_commit_succeeds_on_repo_without_head ... ok
[INFO] [stdout] test config::tests::background_config_defaults_to_sixty_minutes ... ok
[INFO] [stdout] test commit::tests::strip_aid_tags_handles_multiple_blocks ... ok
[INFO] [stdout] test config::tests::effective_budget_not_found ... ok
[INFO] [stdout] test config::tests::effective_budget_found ... ok
[INFO] [stdout] test config::tests::parses_selection_budget_mode ... ok
[INFO] [stdout] test config::tests::parses_usage_budgets ... ok
[INFO] [stdout] test config::tests::parses_background_max_task_duration_override ... ok
[INFO] [stdout] test commit::tests::detect_untracked_finds_new_source_files ... ok
[INFO] [stdout] [master (root-commit) 74b56b6] initial
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 tracked.txt
[INFO] [stdout] test config::tests::updates_check_defaults_to_true_and_allows_override ... ok
[INFO] [stdout] test config::tests::upsert_preserves_other_config ... ok
[INFO] [stdout] test config::tests::parses_webhook_config ... ok
[INFO] [stdout] test config::tests::upsert_creates_new_entry ... ok
[INFO] [stdout] test container::tests::exec_in_container_builds_correct_command_structure ... ok
[INFO] [stdout] test container::tests::mount_home_dirs_returns_expected_args ... ok
[INFO] [stdout] test context::tests::inject_context_format ... ok
[INFO] [stdout] test context::tests::parse_specs_keeps_absolute_paths_unchanged ... ok
[INFO] [stdout] test context::tests::parse_specs_whole_file ... ok
[INFO] [stdout] test container::tests::container_name_formats_input ... ok
[INFO] [stdout] test context::tests::parse_specs_with_items ... ok
[INFO] [stdout] test context::tests::resolve_context_pointers_multiple_files ... ok
[INFO] [stdout] test context::tests::resolve_context_pointers_whole_file ... ok
[INFO] [stdout] test context::tests::resolve_context_pointers_with_items ... ok
[INFO] [stdout] test config::tests::upsert_adds_second_budget ... ok
[INFO] [stdout] test context::tests::resolve_with_item_extraction ... ok
[INFO] [stdout] test cost::tests::composer2_cost_estimate ... ok
[INFO] [stdout] test cost::tests::format_cost_label_codebuff ... ok
[INFO] [stdout] test cost::tests::format_cost_label_special_cases ... ok
[INFO] [stdout] test context::tests::resolve_whole_file ... ok
[INFO] [stdout] test cost::tests::format_cost_variants ... ok
[INFO] [stdout] test cost::tests::gpt41_cost_estimate ... ok
[INFO] [stdout] test cost::tests::kilo_and_free_models_zero_cost ... ok
[INFO] [stdout] test cost::tests::new_model_pricing_entries ... ok
[INFO] [stdout] test cost::tests::unknown_model_returns_none ... ok
[INFO] [stdout] test config::tests::upsert_updates_existing ... ok
[INFO] [stdout] test explore::tests::expands_directories_and_globs ... ok
[INFO] [stdout] test explore::tests::finds_explicit_files ... ok
[INFO] [stdout] test idle_timeout::tests::default_idle_timeout_is_300_seconds ... ok
[INFO] [stdout] ok
[INFO] [stdout] test hooks::tests::parse_cli_hooks_marks_hooks_trusted ... ok
[INFO] [stdout] test idle_timeout::tests::batch_idle_timeout_parses_from_toml ... ok
[INFO] [stdout] test input_signal::tests::writes_and_consumes_response_file ... ok
[INFO] [stdout] test input_signal::tests::writes_and_consumes_steer_file ... ok
[INFO] [stdout] test notify::tests::truncate_prompt_respects_char_boundary ... ok
[INFO] [stdout] test commit::tests::detect_untracked_ignores_artifacts ... ok
[INFO] [stdout] test output::tests::quiet_mode_defaults_off ... ok
[INFO] [stdout] test output::tests::set_quiet_toggles_mode ... ok
[INFO] [stdout] test paths::tests::paths_are_under_aid_dir ... ok
[INFO] [stdout] test paths::tests::steer_signal_path_in_jobs ... ok
[INFO] [stdout] test paths::tests::workspace_dir_uses_tmp ... ok
[INFO] [stdout] test context::tests::parse_specs_resolves_relative_paths_to_absolute ... FAILED
[INFO] [stdout] test hooks::tests::run_hooks_rejects_untrusted_hooks ... ok
[INFO] [stdout] hello
[INFO] [stdout] test process_guard::tests::spawn_and_wait ... ok
[INFO] [stdout] hello
[INFO] [stdout] test commit::tests::rescue_untracked_amends_commit ... ok
[INFO] [stdout] test project::tests::budget_shorthand_day ... ok
[INFO] [stdout] test process_guard::tests::wait_with_timeout_completes ... ok
[INFO] [stdout] test process_guard::tests::spawn_detached ... ok
[INFO] [stdout] test project::tests::budget_shorthand_month ... ok
[INFO] [stdout] test project::tests::budget_shorthand_plain_number ... ok
[INFO] [stdout] test project::tests::detect_project_returns_none_outside_git ... ok
[INFO] [stdout] test project::tests::parses_max_task_cost_from_toml ... ok
[INFO] [stdout] test project::tests::parses_minimal_toml ... ok
[INFO] [stdout] test project::tests::profile_defaults_respect_explicit_values ... ok
[INFO] [stdout] test project::tests::parses_container_image ... ok
[INFO] [stdout] test project::tests::profile_expands_standard_defaults ... ok
[INFO] [stdout] test project::tests::test_read_project_knowledge ... ok
[INFO] [stdout] test prompt::tests::clears_pending_prompt_after_input ... ok
[INFO] [stdout] test project::tests::profile_sets_default_max_task_costs ... ok
[INFO] [stdout] test prompt::tests::detects_inline_question_prompts ... ok
[INFO] [stdout] test prompt::tests::detects_idle_partial_lines_as_prompts ... ok
[INFO] [stdout] test pty_bridge::tests::child_pid_returns_some_while_running ... ok
[INFO] [stdout] test pty_bridge::tests::kill_group_terminates_process ... ok
[INFO] [stdout] test pty_bridge::tests::spawns_echo_in_a_pty ... ok
[INFO] [stdout] test input_signal::tests::rejects_invalid_task_id ... FAILED
[INFO] [stdout] test paths::tests::workspace_dir_rejects_invalid_id ... ok
[INFO] [stdout] test pty_watch::tests::falls_back_to_prompt_when_no_question ... ok
[INFO] [stdout] test project::tests::strict_toml_rejects_unknown_top_level ... ok
[INFO] [stdout] test pty_watch::tests::matches_patterns_without_question_mark ... ok
[INFO] [stdout] test pty_watch::tests::handles_ansi_escaped_output ... ok
[INFO] [stdout] test pty_watch::tests::strip_ansi_removes_escape_codes ... ok
[INFO] [stdout] test rate_limit::tests::test_extract_rate_limit_message_from_402_error_json ... ok
[INFO] [stdout] test rate_limit::tests::test_extract_rate_limit_message_from_error_json ... ok
[INFO] [stdout] test rate_limit::tests::test_extract_rate_limit_message_ignores_init_json ... ok
[INFO] [stdout] test rate_limit::tests::test_extract_rate_limit_message_ignores_noise ... ok
[INFO] [stdout] test rate_limit::tests::test_extract_rate_limit_message_plain_text ... ok
[INFO] [stdout] test pty_watch::tests::stores_recent_question_as_awaiting_prompt_metadata ... ok
[INFO] [stdout] test rate_limit::tests::test_get_rate_limit_info ... ok
[INFO] [stdout] test rate_limit::tests::test_is_rate_limit_error ... ok
[INFO] [stdout] test rate_limit::tests::test_is_rate_limited_returns_false_for_fresh_agents ... ok
[INFO] [stdout] test rate_limit::tests::test_is_rate_limited_expired ... ok
[INFO] [stdout] test rate_limit::tests::test_mark_and_check_rate_limited ... ok
[INFO] [stdout] test rate_limit::tests::test_parse_recovery_time ... ok
[INFO] [stdout] test rate_limit::tests::test_parse_recovery_datetime ... ok
[INFO] [stdout] test sandbox::tests::cannot_sandbox_native_agents ... ok
[INFO] [stdout] test rate_limit::tests::test_rate_limited_agents_returns_empty_initially ... ok
[INFO] [stdout] test sandbox::tests::wrap_command_forwards_env_vars ... ok
[INFO] [stdout] test sandbox::tests::wrap_command_builds_container_run ... ok
[INFO] [stdout] test sandbox::tests::wrap_command_mounts_cwd ... ok
[INFO] [stdout] test sanitize::tests::invalid_branch_names ... ok
[INFO] [stdout] test sanitize::tests::invalid_names ... ok
[INFO] [stdout] test sanitize::tests::invalid_task_id_error_is_human_readable ... ok
[INFO] [stdout] test sanitize::tests::invalid_task_ids ... ok
[INFO] [stdout] test sanitize::tests::invalid_workgroup_ids ... ok
[INFO] [stdout] test sanitize::tests::safe_join_allows_nested ... ok
[INFO] [stdout] test sanitize::tests::safe_join_blocks_traversal ... ok
[INFO] [stdout] test sanitize::tests::valid_names ... ok
[INFO] [stdout] test sanitize::tests::valid_branch_names ... ok
[INFO] [stdout] test sanitize::tests::valid_workgroup_ids ... ok
[INFO] [stdout] test sanitize::tests::valid_task_ids ... ok
[INFO] [stdout] test session::tests::display_shortens_long_session_ids ... ok
[INFO] [stdout] test shared_dir::tests::cleanup_shared_dir_removes_directory ... ok
[INFO] [stdout] test shared_dir::tests::create_shared_dir_creates_directory ... ok
[INFO] [stdout] test shared_dir::tests::shared_dir_path_returns_none_when_missing ... ok
[INFO] [stdout] test skills::tests::auto_skills_skips_missing_defaults ... ok
[INFO] [stdout] test process_guard::tests::wait_with_timeout_kills_on_expiry ... ok
[INFO] [stdout] test skills::tests::auto_skills_returns_agent_defaults_when_installed ... ok
[INFO] [stdout] test skills::tests::format_script_instructions_renders_tool_list ... ok
[INFO] [stdout] test skills::tests::estimate_tokens_uses_length_divided_by_four ... ok
[INFO] [stdout] test pty_watch::tests::finds_question_beyond_six_lines ... ok
[INFO] [stdout] test skills::tests::lists_flat_and_folder_skills ... ok
[INFO] [stdout] test skills::tests::handles_skill_folder_without_optional_content ... ok
[INFO] [stdout] test skills::tests::lists_scripts_and_references_for_folder_skill ... ok
[INFO] [stdout] test process_guard::tests::drop_cleans_up_process_group ... ok
[INFO] [stdout] test skills::tests::load_skill_rejects_invalid_name ... ok
[INFO] [stdout] test skills::tests::loads_flat_skill_for_backward_compatibility ... ok
[INFO] [stdout] test skills::tests::loads_folder_skill_from_skill_md ... ok
[INFO] [stdout] test skills::tests::load_skill_scripts_returns_sorted_metadata ... ok
[INFO] [stdout] test skills::tests::parse_script_metadata_uses_default_description ... ok
[INFO] [stdout] test skills::tests::loads_general_and_agent_specific_gotchas ... ok
[INFO] [stdout] test skills::tests::measure_skill_tokens_includes_gotchas_and_script_listing ... ok
[INFO] [stdout] test skills::tests::parse_script_metadata_extracts_fields ... ok
[INFO] [stdout] test state_tests::state_path_and_roundtrip_use_project_aid_dir ... ok
[INFO] [stdout] test state_tests::refresh_project_state_skips_tasks_without_repo_path ... ok
[INFO] [stdout] test state_tests::summary_formats_key_lines ... FAILED
[INFO] [stdout] test pty_bridge::tests::try_wait_returns_none_while_running ... ok
[INFO] [stdout] test store::mutations::tests::complete_task_atomic_writes_both_task_and_event ... ok
[INFO] [stdout] test pty_bridge::tests::kill_terminates_running_process ... ok
[INFO] [stdout] test store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history ... FAILED
[INFO] [stdout] test state_tests::refresh_project_state_writes_state_after_completion_update ... ok
[INFO] [stdout] test store::queries::tests::finds_matching_tasks_with_keyword_scores ... ok
[INFO] [stdout] test store::queries::state_queries::tests::recent_tasks_for_project_and_last_verify_event_are_project_scoped ... ok
[INFO] [stdout] test store::queries::tests::includes_merged_tasks_in_results ... ok
[INFO] [stdout] test store::queries::tests::aggregates_budget_usage_by_agent_and_window ... ok
[INFO] [stdout] test store::queries::tests::latest_awaiting_reasons_batch_returns_latest_prompt_per_task ... ok
[INFO] [stdout] test store::queries::tests::limits_results_to_positive_scores ... ok
[INFO] [stdout] test store::queries::tests::latest_awaiting_reasons_batch_skips_missing_prompts ... ok
[INFO] [stdout] test store::queries::workgroup_queries::tests::get_finding_returns_matching_row ... ok
[INFO] [stdout] test state_tests::compute_state_aggregates_project_metrics ... FAILED
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_by_category_empty_for_unknown ... ok
[INFO] [stdout] test store::queries::tests::search_memories_escapes_wildcards ... ok
[INFO] [stdout] test store::queries::workgroup_queries::tests::list_findings_filtered_by_severity ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_returns_empty_for_no_tasks ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_by_category_filters_correctly ... ok
[INFO] [stdout] test store::tests::db_tests::optimize_for_concurrency_supports_in_memory_db ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_calculates_success_rate_correctly ... ok
[INFO] [stdout] test store::queries::workgroup_queries::tests::update_finding_roundtrip_persists_review_fields ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_filters_agents_with_fewer_than_five_tasks ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_includes_merged_as_success ... ok
[INFO] [stdout] test store::tests::agent_tests::agent_success_rates_groups_by_agent ... ok
[INFO] [stdout] test store::tests::event_tests::insert_and_get_events ... ok
[INFO] [stdout] test store::tests::memory_tests::increment_memory_counters_updates_usage ... ok
[INFO] [stdout] test store::tests::event_tests::gets_latest_milestone ... ok
[INFO] [stdout] test store::tests::memory_tests::list_memories_returns_only_latest_versions ... ok
[INFO] [stdout] test store::tests::memory_tests::insert_and_update_memory_creates_new_version ... ok
[INFO] [stdout] test store::tests::task_tests::fail_pending_with_reason_persists_reason ... ok
[INFO] [stdout] test store::tests::memory_tests::memory_history_returns_full_chain_from_mid_version ... ok
[INFO] [stdout] test store::tests::task_tests::gets_retry_chain_from_root_to_current ... ok
[INFO] [stdout] test store::tests::task_tests::insert_and_get_task ... ok
[INFO] [stdout] test store::tests::task_tests::insert_and_get_task_persists_dispatch_flags ... ok
[INFO] [stdout] test store::tests::task_tests::list_running_filter ... ok
[INFO] [stdout] test store::tests::task_tests::recent_tasks_for_agent_filters_to_recent_done_tasks ... ok
[INFO] [stdout] test store::tests::task_tests::migrate_adds_repo_path_column ... ok
[INFO] [stdout] test store::tests::task_tests::update_output_path_sets_field ... ok
[INFO] [stdout] test store::tests::task_tests::update_completion ... ok
[INFO] [stdout] test store::tests::task_tests::update_resolved_prompt_persists ... ok
[INFO] [stdout] test system_resources::tests::available_disk_mb_returns_tmp_capacity ... ok
[INFO] [stdout] test system_resources::tests::check_disk_space_handles_zero_threshold ... ok
[INFO] [stdout] test system_resources::tests::parse_available_mb_reads_df_line ... ok
[INFO] [stdout] test system_resources::tests::cpu_count_is_positive ... ok
[INFO] [stdout] test team::tests::empty_dir_returns_empty ... ok
[INFO] [stdout] test system_resources::tests::recommended_max_concurrent_is_in_range ... ok
[INFO] [stdout] test team::tests::list_returns_sorted ... ok
[INFO] [stdout] test team::tests::loads_valid_toml ... ok
[INFO] [stdout] test team::tests::parses_full_team_with_overrides ... ok
[INFO] [stdout] test team::tests::read_knowledge_entries_parses_markdown ... ok
[INFO] [stdout] test team::tests::skips_invalid_toml ... ok
[INFO] [stdout] test team::tests::parses_team_with_toolbox ... ok
[INFO] [stdout] test team::tests::toolbox_defaults_to_empty ... ok
[INFO] [stdout] test templates::tests::apply_template_replaces_placeholder ... ok
[INFO] [stdout] test templates::tests::git_staging_guard_mentions_untracked_files ... ok
[INFO] [stdout] test templates::tests::load_template_rejects_invalid_name ... ok
[INFO] [stdout] test templates::tests::text_edit_guard_does_not_trigger_for_code ... ok
[INFO] [stdout] test templates::tests::text_edit_guard_triggers_for_toml ... ok
[INFO] [stdout] test store_workgroups::tests::update_workgroup_changes_requested_fields ... ok
[INFO] [stdout] test toolbox::tests::empty_dir_returns_no_tools ... ok
[INFO] [stdout] test toolbox::tests::filter_by_auto_inject_empty_returns_all ... ok
[INFO] [stdout] test toolbox::tests::filter_by_auto_inject_filters_correctly ... ok
[INFO] [stdout] test store::tests::workgroup_tests::gets_workgroup_milestones ... ok
[INFO] [stdout] test toolbox::tests::filter_by_task_category_empty_category_keeps_all ... ok
[INFO] [stdout] test store::tests::workgroup_tests::create_and_get_workgroup ... ok
[INFO] [stdout] test templates::tests::text_edit_guard_triggers_for_md_files ... ok
[INFO] [stdout] test store::tests::db_tests::db_stats_returns_valid_values ... ok
[INFO] [stdout] test store_workgroups::tests::delete_workgroup_keeps_historical_task_tags ... ok
[INFO] [stdout] test toolbox::tests::filter_by_task_category_filters_irrelevant ... ok
[INFO] [stdout] test toolbox::tests::filter_by_task_category_keeps_relevant ... ok
[INFO] [stdout] test toolbox::tests::filter_by_task_category_keeps_untagged_tools ... ok
[INFO] [stdout] test toolbox::tests::find_tool_rejects_invalid_name ... ok
[INFO] [stdout] test toolbox::tests::format_empty_returns_empty ... ok
[INFO] [stdout] test toolbox::tests::format_instructions_renders_tools ... ok
[INFO] [stdout] test toolbox::tests::list_finds_toml_and_scripts ... ok
[INFO] [stdout] test toolbox::tests::loads_tool_from_toml_file ... ok
[INFO] [stdout] test toolbox::tests::parses_tool_script_metadata ... ok
[INFO] [stdout] test toolbox::tests::resolve_deduplicates_by_scope_priority ... ok
[INFO] [stdout] test toolbox::tests::project_scope_overrides_global ... ok
[INFO] [stdout] test toolbox::tests::resolve_toolbox_returns_all_without_filter ... ok
[INFO] [stdout] test toolbox::tests::toml_defaults_when_optional_fields_omitted ... ok
[INFO] [stdout] test toolbox::tests::tool_scope_labels ... ok
[INFO] [stdout] test tui::metrics::tests::parses_cpu_and_rss_from_ps_output ... ok
[INFO] [stdout] test tui::metrics::tests::rejects_incomplete_ps_output ... ok
[INFO] [stdout] test tui::app::tests::filters_specific_task_scope ... ok
[INFO] [stdout] test tui::app::tests::detail_mode_cycles_tabs_and_resets_scroll ... ok
[INFO] [stdout] test tui::tests::toggles_dashboard_mode_with_d_key ... ok
[INFO] [stdout] test tui::app::tests::detail_mode_keeps_selection_stable_and_resets_on_escape ... ok
[INFO] [stdout] test tui::app::tests::filters_today_view_by_group ... ok
[INFO] [stdout] test tui::app::tests::keeps_ungrouped_tasks_visible_with_group_filter ... ok
[INFO] [stdout] test tui::app::tests::loads_running_task_milestone ... ok
[INFO] [stdout] test tui::tree_data::tests::flat_tasks_no_hierarchy ... ok
[INFO] [stdout] test tui::tree_data::tests::nested_hierarchy ... ok
[INFO] [stdout] test tui::tree_data::tests::workgroup_tasks_grouped ... ok
[INFO] [stdout] test tui::ui::tests::status_to_color_maps_terminal_states ... ok
[INFO] [stdout] test tui::ui::ui_detail::tests::event_kind_color_matches_event_list_styling ... ok
[INFO] [stdout] test tui::tree_data::tests::parent_child_creates_hierarchy ... ok
[INFO] [stdout] test tui::ui::ui_helpers::tests::detail_output_parses_log_jsonl_content ... ok
[INFO] [stdout] test tui::ui::ui_tree::tests::tree_duration_formats_completed_minutes ... ok
[INFO] [stdout] test tui::ui::ui_tree::tests::tree_duration_non_running_without_duration_is_dash ... ok
[INFO] [stdout] test tui::ui::ui_helpers::tests::detail_output_prefers_output_file ... ok
[INFO] [stdout] test types::tests::agent_display_name_defaults_for_custom ... ok
[INFO] [stdout] test types::tests::agent_display_name_for_built_in_agents ... ok
[INFO] [stdout] test types::tests::agent_display_name_returns_custom_name ... ok
[INFO] [stdout] test types::tests::all_builtin_excludes_custom ... ok
[INFO] [stdout] test types::tests::all_builtin_matches_parse_str_coverage ... ok
[INFO] [stdout] test types::tests::all_includes_custom ... ok
[INFO] [stdout] test types::tests::memory_type_parse_str_roundtrip ... ok
[INFO] [stdout] test types::tests::profile_returns_none_for_custom ... ok
[INFO] [stdout] test types::tests::pending_reason_parse_str_roundtrip ... ok
[INFO] [stdout] test types::tests::profile_returns_some_for_all_builtin ... ok
[INFO] [stdout] test update_check::tests::cache_round_trip_reads_and_writes ... ok
[INFO] [stdout] test update_check::tests::maybe_check_update_uses_fresh_cache_without_panicking ... ok
[INFO] [stdout] test update_check::tests::parse_crates_io_response_extracts_max_version ... ok
[INFO] [stdout] test update_check::tests::version_is_newer_uses_semver_parts ... ok
[INFO] [stdout] test usage::tests::agent_analytics_trend_and_top_tasks ... ok
[INFO] [stdout] test usage::tests::calculates_agent_execution_stats ... ok
[INFO] [stdout] test usage::tests::usage_window_parses_last_days ... ok
[INFO] [stdout] test verify::tests::auto_detect_skips_empty_directories ... ok
[INFO] [stdout] test verify::tests::auto_detects_pyproject_projects ... ok
[INFO] [stdout] test verify::tests::auto_detects_python_files_without_project_metadata ... ok
[INFO] [stdout] test verify::tests::auto_detects_setup_py_projects ... ok
[INFO] [stdout] test tui::tests::toggles_stats_mode_with_s_key ... ok
[INFO] [stdout] test tui::tests::toggles_multipane_mode_with_m_key ... ok
[INFO] [stdout] test verify::tests::format_report_fail_shows_output ... ok
[INFO] [stdout] test verify::tests::format_report_pass ... ok
[INFO] [stdout] test verify::tests::rust_detection_takes_priority_over_python_files ... ok
[INFO] [stdout] test tui::ui::ui_tree::tests::tree_duration_formats_completed_seconds ... ok
[INFO] [stdout] test verify::tests::verify_does_not_expand_shell_operators ... ok
[INFO] [stdout] test tui::tests::toggles_show_all_with_a_key ... ok
[INFO] [stdout] test verify::tests::verify_fail_case ... ok
[INFO] [stdout] test verify::tests::verify_no_project_file_skips ... ok
[INFO] [stdout] test verify::tests::verify_pass_case ... ok
[INFO] [stdout] test tui::tests::toggles_tree_mode_with_t_key ... ok
[INFO] [stdout] test watcher::tests::cost_ceiling_only_triggers_above_limit ... ok
[INFO] [stdout] test watcher::tests::finding_event_parses_plain_text_lines ... ok
[INFO] [stdout] test watcher::tests::completion_metadata_updates_summary_fields ... ok
[INFO] [stdout] test watcher::tests::finding_inside_string_literal_is_rejected ... ok
[INFO] [stdout] test watcher::tests::loop_detector_distinguishes_long_details ... ok
[INFO] [stdout] test watcher::tests::loop_detector_ignores_empty_details ... ok
[INFO] [stdout] test watcher::tests::milestone_event_parses_json_lines ... ok
[INFO] [stdout] test watcher::tests::milestone_event_parses_plain_text_lines ... ok
[INFO] [stdout] test watcher::tests::milestone_inside_json_string_value_is_rejected ... ok
[INFO] [stdout] test watcher::tests::milestone_lines_stripped_from_output ... ok
[INFO] [stdout] test watcher::tests::milestone_inside_string_literal_is_rejected ... ok
[INFO] [stdout] test watcher::tests::non_completion_events_do_not_change_summary_fields ... ok
[INFO] [stdout] test watcher::tests::real_finding_still_extracted ... ok
[INFO] [stdout] test watcher::tests::real_milestone_still_extracted ... ok
[INFO] [stdout] test watcher::tests::synthetic_tracker_emits_first_edit_after_reads ... ok
[INFO] [stdout] test watcher::tests::synthetic_tracker_emits_milestone_after_three_reads ... ok
[INFO] [stdout] test watcher::tests::synthetic_tracker_stays_disabled_when_reasoning_exists ... ok
[INFO] [stdout] test workgroup::tests::compression_preserves_recent ... ok
[INFO] [stdout] test workgroup::tests::finding_content_truncated_at_500 ... ok
[INFO] [stdout] test workgroup::tests::includes_findings_from_investigation ... ok
[INFO] [stdout] test workgroup::tests::includes_shared_and_file_context ... ok
[INFO] [stdout] test workgroup::tests::includes_shared_findings ... ok
[INFO] [stdout] test workgroup::tests::long_context_compressed ... ok
[INFO] [stdout] test workgroup::tests::milestone_content_truncated_at_500 ... ok
[INFO] [stdout] test workgroup::tests::returns_prompt_when_no_context_exists ... ok
[INFO] [stdout] test workgroup::tests::short_context_unchanged ... ok
[INFO] [stdout] test usage::tests::renders_configured_budget_usage ... ok
[INFO] [stdout] test workgroup::tests::short_finding_unchanged ... ok
[INFO] [stdout] test watcher::tests::loop_detector_patterns ... ok
[INFO] [stdout] test verify::tests::enforce_verify_status_keeps_done_passed_verify_as_done ... ok
[INFO] [stdout] test verify::tests::enforce_verify_status_keeps_done_on_vfail ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpmcCDRx/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpTi8Teo/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpfC5DoM/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmptxI1HW/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpfv2mw7/.git/
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmp3hecBb/.git/
[INFO] [stdout] [main (root-commit) f81a588] init
[INFO] [stdout]  2 files changed, 2 insertions(+)
[INFO] [stdout]  create mode 100644 Cargo.lock
[INFO] [stdout]  create mode 100644 file.txt
[INFO] [stdout] [main (root-commit) 0beb94c] init
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 file.txt
[INFO] [stdout] test worktree::tests::create_worktree_rejects_invalid_branch_name ... ok
[INFO] [stdout] [main (root-commit) 0beb94c] init
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 file.txt
[INFO] [stdout] [main (root-commit) 0beb94c] init
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 file.txt
[INFO] [stdout] [main (root-commit) 0beb94c] init
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 file.txt
[INFO] [stderr] Preparing worktree (new branch 'feat/reuse-16-1774577996504590634')
[INFO] [stdout] test worktree::tests::create_worktree_syncs_cargo_lock ... ok
[INFO] [stdout] test worktree::tests::sync_context_files_copies_missing_files ... ok
[INFO] [stdout] test worktree::tests::sync_context_files_skips_existing_files ... ok
[INFO] [stderr] Preparing worktree (new branch 'feat/orphan-16-1774577996500294545')
[INFO] [stdout] test worktree::tests::validate_git_repo_fails_on_nonrepo ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpZwfZsz/.git/
[INFO] [stdout] test worktree::tests::validate_git_repo_succeeds_on_real_repo ... ok
[INFO] [stdout] [main (root-commit) 4971c0e] init
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 base.txt
[INFO] [stderr] Switched to a new branch 'base-16-1774577996559604648'
[INFO] [stdout] HEAD is now at 0beb94c init
[INFO] [stdout] HEAD is now at 0beb94c init
[INFO] [stdout] test worktree::tests::create_worktree_rejects_non_aid_branch_on_force_reset_fallback ... ok
[INFO] [stdout] test worktree::tests::worktree_lock_stale_pid_is_cleared ... ok
[INFO] [stdout] test worktree::tests::worktree_lock_write_and_read ... ok
[INFO] [stdout] [base-16-1774577996559604648 f4f23ab] base
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 inherited.txt
[INFO] [stderr] Switched to branch 'main'
[INFO] [stdout] test worktree::tests::create_worktree_allows_aid_branch_on_force_reset_fallback ... ok
[INFO] [stdout] Initialized empty Git repository in /tmp/.tmpKbH8lc/.git/
[INFO] [stdout] test worktree::tests::create_worktree_reuses_existing_branch_worktree ... ok
[INFO] [stdout] test worktree::tests::create_worktree_prunes_orphaned_branch_worktree ... ok
[INFO] [stdout] [main (root-commit) ebb0ee1] base
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 base.txt
[INFO] [stdout] test worktree::tests::create_worktree_with_base_branch_inherits_base_content ... ok
[INFO] [stderr] Switched to a new branch 'agent-branch'
[INFO] [stdout] test verify::tests::verify_kills_background_grandchildren ... FAILED
[INFO] [stdout] [agent-branch 998433f] agent one
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 agent.txt
[INFO] [stdout] [agent-branch da0bc36] agent two
[INFO] [stdout]  1 file changed, 1 insertion(+)
[INFO] [stdout]  create mode 100644 agent2.txt
[INFO] [stdout] test worktree::tests::worktree_changed_files_reports_committed_files ... ok
[INFO] [stdout] test cmd::wait::tests::wait_for_task_ids_tracks_group_tasks_added_mid_watch ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- agent::selection::tests::fallback_chain_skips_rate_limited stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'agent::selection::tests::fallback_chain_skips_rate_limited' (98) panicked at src/agent/selection/tests.rs:530:5:
[INFO] [stdout] assertion failed: result.is_some()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cea - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e094359502 - core[786f478f706679df]::panicking::panic
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x63e093a6fbf8 - aid[df3220e873c883d0]::agent::selection::tests::fallback_chain_skips_rate_limited
[INFO] [stdout]                                at /opt/rustwide/workdir/src/agent/selection/tests.rs:530:5
[INFO] [stdout]   21:     0x63e093a45717 - aid[df3220e873c883d0]::agent::selection::tests::fallback_chain_skips_rate_limited::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/agent/selection/tests.rs:525:39
[INFO] [stdout]   22:     0x63e0936b4e66 - <aid[df3220e873c883d0]::agent::selection::tests::fallback_chain_skips_rate_limited::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   42:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   43:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   44:     0x76eff29c3a64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- agent::selection::tests::gemini_in_fallback_chain stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'agent::selection::tests::gemini_in_fallback_chain' (108) panicked at src/agent/selection/tests.rs:521:5:
[INFO] [stdout] Gemini should have a fallback agent
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cea - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e093a6cb9e - aid[df3220e873c883d0]::agent::selection::tests::gemini_in_fallback_chain
[INFO] [stdout]                                at /opt/rustwide/workdir/src/agent/selection/tests.rs:521:5
[INFO] [stdout]   20:     0x63e093a45507 - aid[df3220e873c883d0]::agent::selection::tests::gemini_in_fallback_chain::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/agent/selection/tests.rs:518:30
[INFO] [stdout]   21:     0x63e0936b4ba6 - <aid[df3220e873c883d0]::agent::selection::tests::gemini_in_fallback_chain::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   24:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   25:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   30:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   31:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   32:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   34:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   39:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   41:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   43:     0x76eff29c3a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited' (297) panicked at src/cmd/batch_retry.rs:157:9:
[INFO] [stdout] assertion `left != right` failed: Should use fallback when rate-limited
[INFO] [stdout]   left: "codex"
[INFO] [stdout]  right: "codex"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e094359453 - core[786f478f706679df]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x63e0939070b5 - core[786f478f706679df]::panicking::assert_failed::<alloc[64763625b5a07cdb]::string::String, &str>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x63e093822fca - aid[df3220e873c883d0]::cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cmd/batch_retry.rs:157:9
[INFO] [stdout]   22:     0x63e093801507 - aid[df3220e873c883d0]::cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/cmd/batch_retry.rs:147:47
[INFO] [stdout]   23:     0x63e0936b62e6 - <aid[df3220e873c883d0]::cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- context::tests::parse_specs_resolves_relative_paths_to_absolute stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'context::tests::parse_specs_resolves_relative_paths_to_absolute' (1348) panicked at src/context.rs:190:36:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Custom { kind: ReadOnlyFilesystem, error: PathError { path: "/opt/rustwide/workdir/.tmp6urzF0", err: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" } } }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e0943592b2 - core[786f478f706679df]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x63e093ba1704 - <core[786f478f706679df]::result::Result<tempfile[81ecc557a5431c4a]::dir::TempDir, std[f92b4c606f291077]::io::error::Error>>::unwrap
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x63e093ba1704 - aid[df3220e873c883d0]::context::tests::parse_specs_resolves_relative_paths_to_absolute
[INFO] [stdout]                                at /opt/rustwide/workdir/src/context.rs:190:36
[INFO] [stdout]   22:     0x63e093b75f07 - aid[df3220e873c883d0]::context::tests::parse_specs_resolves_relative_paths_to_absolute::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/context.rs:188:57
[INFO] [stdout]   23:     0x63e0936aec66 - <aid[df3220e873c883d0]::context::tests::parse_specs_resolves_relative_paths_to_absolute::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- input_signal::tests::rejects_invalid_task_id stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'input_signal::tests::rejects_invalid_task_id' (1372) panicked at src/input_signal.rs:101:54:
[INFO] [stdout] called `Result::unwrap_err()` on an `Ok` value: ()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e0943592b2 - core[786f478f706679df]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x63e093c9b39f - <core[786f478f706679df]::result::Result<(), anyhow[46a592b7da052030]::Error>>::unwrap_err
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/result.rs:1329:22
[INFO] [stdout]   21:     0x63e093745450 - aid[df3220e873c883d0]::input_signal::tests::rejects_invalid_task_id
[INFO] [stdout]                                at /opt/rustwide/workdir/src/input_signal.rs:101:54
[INFO] [stdout]   22:     0x63e093703d27 - aid[df3220e873c883d0]::input_signal::tests::rejects_invalid_task_id::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/input_signal.rs:100:33
[INFO] [stdout]   23:     0x63e0936ab2e6 - <aid[df3220e873c883d0]::input_signal::tests::rejects_invalid_task_id::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- state_tests::summary_formats_key_lines stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'state_tests::summary_formats_key_lines' (1479) panicked at src/state_tests.rs:172:5:
[INFO] [stdout] assertion failed: summary.contains("[Project State: alpha]")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cea - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e094359502 - core[786f478f706679df]::panicking::panic
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x63e09394afd3 - aid[df3220e873c883d0]::state_tests::summary_formats_key_lines
[INFO] [stdout]                                at /opt/rustwide/workdir/src/state_tests.rs:172:5
[INFO] [stdout]   21:     0x63e09393e747 - aid[df3220e873c883d0]::state_tests::summary_formats_key_lines::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/state_tests.rs:166:31
[INFO] [stdout]   22:     0x63e0936aa3e6 - <aid[df3220e873c883d0]::state_tests::summary_formats_key_lines::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   25:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   26:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   27:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   30:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   32:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   33:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   34:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   35:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   36:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   40:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   42:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   43:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   44:     0x76eff29c3a64 - clone
[INFO] [stdout]   45:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history' (1481) panicked at src/store/queries/state_queries.rs:181:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: Some(6.333333333333333)
[INFO] [stdout]  right: Some(6.0)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e0943593f3 - core[786f478f706679df]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x63e09390691d - core[786f478f706679df]::panicking::assert_failed::<core[786f478f706679df]::option::Option<f64>, core[786f478f706679df]::option::Option<f64>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x63e093a7ed03 - aid[df3220e873c883d0]::store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history
[INFO] [stdout]                                at /opt/rustwide/workdir/src/store/queries/state_queries.rs:181:9
[INFO] [stdout]   22:     0x63e093a46597 - aid[df3220e873c883d0]::store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/store/queries/state_queries.rs:159:76
[INFO] [stdout]   23:     0x63e0936b7026 - <aid[df3220e873c883d0]::store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- state_tests::compute_state_aggregates_project_metrics stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'state_tests::compute_state_aggregates_project_metrics' (1474) panicked at src/state_tests.rs:94:5:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: None
[INFO] [stdout]  right: Some("codex")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e0943593f3 - core[786f478f706679df]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x63e093906737 - core[786f478f706679df]::panicking::assert_failed::<core[786f478f706679df]::option::Option<&str>, core[786f478f706679df]::option::Option<&str>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x63e09394beb6 - aid[df3220e873c883d0]::state_tests::compute_state_aggregates_project_metrics
[INFO] [stdout]                                at /opt/rustwide/workdir/src/state_tests.rs:94:5
[INFO] [stdout]   22:     0x63e09393e777 - aid[df3220e873c883d0]::state_tests::compute_state_aggregates_project_metrics::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/state_tests.rs:51:46
[INFO] [stdout]   23:     0x63e0936aa426 - <aid[df3220e873c883d0]::state_tests::compute_state_aggregates_project_metrics::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- verify::tests::verify_kills_background_grandchildren stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'verify::tests::verify_kills_background_grandchildren' (1622) panicked at src/verify_tests.rs:165:5:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: 0
[INFO] [stdout]  right: -1
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x63e09433e19a - std[f92b4c606f291077]::backtrace_rs::backtrace::trace_unsynchronized::<std[f92b4c606f291077]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x63e09433e19a - std[f92b4c606f291077]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x63e09433e19a - <<std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[786f478f706679df]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x63e094358d7a - <core[786f478f706679df]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x63e094358d7a - core[786f478f706679df]::fmt::write
[INFO] [stdout]    6:     0x63e094345032 - std[f92b4c606f291077]::io::default_write_fmt::<alloc[64763625b5a07cdb]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x63e094345032 - <alloc[64763625b5a07cdb]::vec::Vec<u8> as std[f92b4c606f291077]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x63e094317bff - <std[f92b4c606f291077]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x63e094317bff - std[f92b4c606f291077]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x63e0943341c9 - std[f92b4c606f291077]::panicking::default_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x63e093dca7bc - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x63e093dca7bc - test[20e1f0ae6cad7a17]::test_main_with_exit_callback::<test[20e1f0ae6cad7a17]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x63e094334442 - <alloc[64763625b5a07cdb]::boxed::Box<dyn for<'a, 'b> core[786f478f706679df]::ops::function::Fn<(&'a std[f92b4c606f291077]::panic::PanicHookInfo<'b>,), Output = ()> + core[786f478f706679df]::marker::Sync + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::Fn<(&std[f92b4c606f291077]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x63e094334442 - std[f92b4c606f291077]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x63e094317cb8 - std[f92b4c606f291077]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x63e09430ec49 - std[f92b4c606f291077]::sys::backtrace::__rust_end_short_backtrace::<std[f92b4c606f291077]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x63e094318d0d - __rustc[8241495c18a89d70]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x63e09435953c - core[786f478f706679df]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x63e0943593f3 - core[786f478f706679df]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x63e094263fa9 - core[786f478f706679df]::panicking::assert_failed::<i32, i32>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x63e0939680c7 - aid[df3220e873c883d0]::verify::tests::verify_kills_background_grandchildren
[INFO] [stdout]                                at /opt/rustwide/workdir/src/verify_tests.rs:165:5
[INFO] [stdout]   22:     0x63e09393fe87 - aid[df3220e873c883d0]::verify::tests::verify_kills_background_grandchildren::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/verify_tests.rs:147:43
[INFO] [stdout]   23:     0x63e0936ae8a6 - <aid[df3220e873c883d0]::verify::tests::verify_kills_background_grandchildren::{closure#0} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x63e093dbe89b - <fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x63e093dbe89b - test[20e1f0ae6cad7a17]::__rust_begin_short_backtrace::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, fn() -> core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x63e093dcb28b - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x63e093dcb28b - std[f92b4c606f291077]::panicking::catch_unwind::<core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>, core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x63e093dcb28b - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<test[20e1f0ae6cad7a17]::run_test_in_process::{closure#0}>, core[786f478f706679df]::result::Result<(), alloc[64763625b5a07cdb]::string::String>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test_in_process
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x63e093dcb28b - test[20e1f0ae6cad7a17]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x63e093dc69a4 - test[20e1f0ae6cad7a17]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x63e093dc69a4 - std[f92b4c606f291077]::sys::backtrace::__rust_begin_short_backtrace::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x63e093dcde92 - <core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::do_call::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x63e093dcde92 - std[f92b4c606f291077]::panicking::catch_unwind::<(), core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x63e093dcde92 - std[f92b4c606f291077]::panic::catch_unwind::<core[786f478f706679df]::panic::unwind_safe::AssertUnwindSafe<std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x63e093dcde92 - std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked::<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x63e093dcde92 - <std[f92b4c606f291077]::thread::lifecycle::spawn_unchecked<test[20e1f0ae6cad7a17]::run_test::{closure#1}, ()>::{closure#1} as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x63e09433d14f - <alloc[64763625b5a07cdb]::boxed::Box<dyn core[786f478f706679df]::ops::function::FnOnce<(), Output = ()> + core[786f478f706679df]::marker::Send> as core[786f478f706679df]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x63e09433d14f - <std[f92b4c606f291077]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/1f7f8ea0721a3b1eb73e6c6d25cccb371434b320/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x76eff2936aa4 - <unknown>
[INFO] [stdout]   45:     0x76eff29c3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     agent::selection::tests::fallback_chain_skips_rate_limited
[INFO] [stdout]     agent::selection::tests::gemini_in_fallback_chain
[INFO] [stdout]     cmd::batch::batch_retry::tests::retry_uses_fallback_when_rate_limited
[INFO] [stdout]     context::tests::parse_specs_resolves_relative_paths_to_absolute
[INFO] [stdout]     input_signal::tests::rejects_invalid_task_id
[INFO] [stdout]     state_tests::compute_state_aggregates_project_metrics
[INFO] [stdout]     state_tests::summary_formats_key_lines
[INFO] [stdout]     store::queries::state_queries::tests::project_agent_success_rates_and_avg_cost_filter_to_project_history
[INFO] [stdout]     verify::tests::verify_kills_background_grandchildren
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 854 passed; 9 failed; 3 ignored; 0 measured; 0 filtered out; finished in 5.81s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin aid`
[INFO] running `Command { std: "docker" "inspect" "3919bf9d9359d5991c36b84792d9735d9fcbe2399e09b68f3f01825ef166d3c4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3919bf9d9359d5991c36b84792d9735d9fcbe2399e09b68f3f01825ef166d3c4", kill_on_drop: false }`
[INFO] [stdout] 3919bf9d9359d5991c36b84792d9735d9fcbe2399e09b68f3f01825ef166d3c4
